Daily Usenet report

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

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Dec 1 06:09:03 newsfeed overchan[572917]: input line too long, skipping
Dec 1 06:30:03 newsfeed pgpverify[579543]: pgpverify: /usr/bin/gpg1: no such file
Dec 1 06:32:23 newsfeed overchan[572917]: input line too long, skipping
Dec 1 09:51:53 newsfeed nnrpd[588565]: SERVER perl filter not defined
Dec 1 13:11:48 newsfeed overchan[572917]: input line too long, skipping
Dec 1 14:30:53 newsfeed overchan[572917]: input line too long, skipping
Dec 1 14:57:06 newsfeed overchan[572917]: input line too long, skipping
Dec 1 15:10:13 newsfeed overchan[572917]: input line too long, skipping
Dec 1 15:17:42 newsfeed overchan[572917]: input line too long, skipping
Dec 1 15:18:17 newsfeed overchan[572917]: input line too long, skipping
Dec 1 15:18:56 newsfeed overchan[572917]: input line too long, skipping
Dec 1 15:36:28 newsfeed overchan[572917]: input line too long, skipping
Dec 1 16:48:26 newsfeed overchan[572917]: input line too long, skipping
Dec 1 16:49:18 newsfeed overchan[572917]: input line too long, skipping
Dec 1 20:26:27 newsfeed overchan[572917]: input line too long, skipping
Dec 1 20:27:08 newsfeed overchan[572917]: input line too long, skipping
Dec 1 22:59:18 newsfeed overchan[572917]: input line too long, skipping
Dec 2 01:22:36 newsfeed overchan[572917]: input line too long, skipping
Dec 2 01:27:34 newsfeed overchan[572917]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 185273 89.8%21.7 MB 89.9%
innd 11782 5.7%1.5 MB 6.2%
nnrpd 7636 3.7%780.3 KB 3.2%
innfeed 1491 0.7%167.3 KB 0.7%
overchan 18 0.0%2.2 KB 0.0%
controlchan 12 0.0%2.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 206213 100.0%24.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 183769 89.6%
Negative hits 12660 6.2%
Positive hits 8258 4.0%
Cache misses 481 0.2%
TOTAL: 4 205168 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:07.700 0.0%841 0.000 9.156 52.000
article cleanup00:00:01.302 0.0%184205 0.002 0.007 0.015
article logging00:00:04.072 0.0%184225 0.011 0.022 0.037
article parse00:00:06.504 0.0%696876 0.006 0.009 0.015
article write00:00:39.459 0.0%173237 0.085 0.228 2.022
artlog/artcncl00:00:00.009 0.0%840 0.000 0.011 0.100
data move00:00:01.162 0.0%1036601 0.000 0.001 0.003
hisgrep/artcncl00:00:03.430 0.0%799 0.000 4.293 23.000
hishave/artcncl00:00:01.831 0.0%841 0.000 2.177 15.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:11:43.956 0.8%204327 1.674 3.445 6.781
history sync00:00:00.018 0.0%315 0.000 0.057 0.667
history write00:16:34.233 1.2%183727 3.007 5.411 9.625
hiswrite/artcncl00:00:00.244 0.0%42 0.000 5.810 10.000
idle23:27:02.209 97.7%864463 21.353 97.659 21464.929
nntp read00:00:13.814 0.0%708116 0.000 0.020 1.000
overview write00:00:00.506 0.0%173237 0.000 0.003 0.008
perl filter00:03:10.457 0.2%183727 0.727 1.037 1.473
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:05.841 0.0%387636 0.009 0.015 0.028
TOTAL: 24:00:30.56223:59:56.747100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.088 0.0%41192 0.000 0.002 0.011
article prepare00:00:00.000 0.0%356 0.000 0.000 0.000
article read00:00:00.008 0.0%89 0.000 0.090 1.000
backlog stats00:00:00.068 0.0%167684 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.850 0.0%95645 0.002 0.009 0.019
data write00:00:02.162 0.0%54539 0.000 0.040 0.077
idle23:53:48.408100.0%167684 237.912 513.039 19300.613
status file00:00:00.261 0.0%385 0.000 0.678 3.000
TOTAL: 23:54:24.08423:53:51.845100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:18.512 54.3%4285 0.000 4.320 10023.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.157 0.5%10549 0.000 0.015 0.500
readart00:00:00.002 0.0%122 0.000 0.016 0.500
TOTAL: 00:00:34.09800:00:18.671 54.8%----

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
moderator@dana.de001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 59 173439 172440 12 987 99%44:10:12
2news.icm.edu.pl 3 18514 988 7499 10027 5%24:23:06
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 64 191954 173429 7511 11014 90%68:33:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.9 GB7.0 MB11.5 MB1.9 GB 99%11.5 KB
2news.icm.edu.pl16.1 MB1.2 MB195.7 MB213.0 MB 7%19.8 KB
3localhost1.7 KB0.0 KB0.0 KB1.7 KB100%1.7 KB
TOTAL: 31.9 GB8.3 MB207.2 MB2.1 GB 90%12.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 1 04:15:02 - 04:59:59 506 0.3% 0.197.5 MB 0.4% 2.86
Dec 1 05:00:00 - 05:59:59 6230 3.6% 1.7368.4 MB 3.5% 19.45
Dec 1 06:00:00 - 06:59:59 7005 4.0% 1.9575.0 MB 3.9% 21.34
Dec 1 07:00:00 - 07:59:59 8006 4.6% 2.2296.1 MB 4.9% 27.33
Dec 1 08:00:00 - 08:59:59 8572 4.9% 2.38107.0 MB 5.5% 30.43
Dec 1 09:00:00 - 09:59:59 8888 5.1% 2.47120.4 MB 6.2% 34.24
Dec 1 10:00:00 - 10:59:59 8558 4.9% 2.3888.5 MB 4.5% 25.16
Dec 1 11:00:00 - 11:59:59 8580 4.9% 2.3878.7 MB 4.0% 22.37
Dec 1 12:00:00 - 12:59:59 9617 5.5% 2.6795.2 MB 4.9% 27.09
Dec 1 13:00:00 - 13:59:59 9435 5.4% 2.62159.9 MB 8.2% 45.49
Dec 1 14:00:00 - 14:59:59 8871 5.1% 2.4697.6 MB 5.0% 27.78
Dec 1 15:00:00 - 15:59:59 7918 4.6% 2.2085.1 MB 4.4% 24.22
Dec 1 16:00:00 - 16:59:59 7024 4.1% 1.9582.6 MB 4.2% 23.51
Dec 1 17:00:00 - 17:59:59 6669 3.8% 1.8562.3 MB 3.2% 17.73
Dec 1 18:00:00 - 18:59:59 5481 3.2% 1.5257.7 MB 3.0% 16.41
Dec 1 19:00:00 - 19:59:59 6114 3.5% 1.7067.7 MB 3.5% 19.26
Dec 1 20:00:00 - 20:59:59 7768 4.5% 2.1676.8 MB 3.9% 21.86
Dec 1 21:00:00 - 21:59:59 7579 4.4% 2.1174.1 MB 3.8% 21.08
Dec 1 22:00:00 - 22:59:59 7875 4.5% 2.19107.0 MB 5.5% 30.43
Dec 1 23:00:00 - 23:59:59 7646 4.4% 2.1274.7 MB 3.8% 21.24
Dec 2 00:00:00 - 00:59:59 5939 3.4% 1.6562.3 MB 3.2% 17.71
Dec 2 01:00:00 - 01:59:59 5505 3.2% 1.5359.9 MB 3.1% 17.05
Dec 2 02:00:00 - 02:59:59 6488 3.7% 1.8071.1 MB 3.7% 20.23
Dec 2 03:00:00 - 03:59:59 6014 3.5% 1.6762.0 MB 3.2% 17.65
Dec 2 04:00:00 - 04:15:01 1142 0.7% 1.2710.3 MB 0.5% 11.65
TOTAL: 23:59:59 173430 100.0% 2.011.9 GB 100.0% 23.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.icm.edu.pl 9996 2 0 84 0 0 0 0 9910
2newsfeed.pionier.net.pl 1007 592 0 395 0 0 0 0 20
TOTAL: 2 11003 594 0 479 0 0 0 0 9930

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.mobile.android 201
uk.railway 125
alt.binaries.erotica.divx 94
eternal-september.support 36
fr.misc.actualite.covid19 33
hr.sci.med 18
fr.comp.os.android 18
xs4all.voip 9
it.tlc.cellulari.android 8
eternal-september.talk 8
grisbi.user.french 6
comp.sys.raspberry-pi 6
eternal-september.newusers 6
fido7.english-tutor 5
eternal-september.test 4
alt.comp.software.seamonkey 3
alt.comp.software.firefox 3
fr.usenet.abus.nocem 2
eternal-september.grouprequests 1
grisbi.test 1
TOTAL: 27 594

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 9236
Scoring filter (9) 462
Scoring filter (8) 124
Scoring filter (11) 28
EMP (md5) 27
Scoring filter (10) 17
Scoring filter (12) 13
Scoring filter (13) 3
TOTAL: 8 9910

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 54218 63 39883 24 0 2 0%23:57:36
2poznan 625 2 496 0 0 77 0%23:29:25
3panorama 0 0 0 0 0 41216 0%23:57:37
4nask 0 0 0 0 0 34239 0%23:57:37
5okapi 0 0 0 0 0 914 0%23:57:37
TOTAL: 5 54843 65 40379 24 0 76448 0%119:19:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm331.5 KB114.8 KB446.3 KB0.0 KB/s5.1 KB23:57:36
2poznan40.7 KB0.0 KB40.7 KB0.0 KB/s20.3 KB23:29:25
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:37
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:37
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:37
TOTAL: 5372.2 KB114.8 KB487.0 KB0.0 KB/s5.5 KB119:19:52
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama3.8 MB
TOTAL: 13.8 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 122358.6 KB 9 0 000:00:07
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 122358.6 KB 9 1 000:00:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1729 122358.6 KB 9 1 000:00:21
2unresolved 101 00.0 KB 0 0 000:00:13
3*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 31831 122358.6 KB 9 1 000:00:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 4.179 7.313 0.00000:00:13
104.152.52.147 0.011 0.000 0.00000:00:10
web.man.lodz.pl 0.791 1.470 0.00000:00:07
80.111.142.213 0.026 0.003 0.00000:00:02
212.51.192.185 0.353 0.507 0.00000:00:01
118.149.216.162.bc.googleusercontent.com 0.006 0.006 0.00000:00:00
isvcs01.man.lodz.pl 0.005 0.008 0.00000:00:00
TOTAL: 7 5.371 9.307 0.00000:00:34

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
118.149.216.162.bc.googleusercontent.com 1
104.152.52.147 1
TOTAL: 5 1542

NNRP unrecognized commands (by host):

SystemConn
118.149.216.162.bc.googleusercontent.com 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
User-Agent: Expanse, a Palo Alto Network... 1
Host: 212.191.2.21:119 1
TOTAL: 3 3

Newsgroup request counts (by category):

CategoryCountPct
1pl 122100.0%
TOTAL: 1 122100.0%

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

NewsgroupCount
1pl.comp.pecet 120
2pl.comp.os.ms-windows.winnt 2
TOTAL: 2 122