Daily Usenet report

May 12 15:00:02 -- May 13 15:00:05

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

May 12 15:01:10 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
May 12 20:30:03 colo-sc-1 pgpverify[344]: pgpverify: verification failed
May 12 20:30:03 colo-sc-1 controlchan[24102]: skipping newgroup y moderator@dana.de (pgpverify failed) in <newgroup-de.comm.geraete.mobil-2022-05-12@dana.de>
May 12 20:45:02 colo-sc-1 pgpverify[2238]: pgpverify: verification failed
May 12 20:45:02 colo-sc-1 pgpverify[2246]: pgpverify: verification failed
May 12 20:45:02 colo-sc-1 pgpverify[2254]: pgpverify: verification failed
May 12 20:45:03 colo-sc-1 pgpverify[2262]: pgpverify: verification failed
May 12 20:45:03 colo-sc-1 pgpverify[2270]: pgpverify: verification failed
May 12 20:45:06 colo-sc-1 pgpverify[2285]: pgpverify: verification failed
May 12 20:45:07 colo-sc-1 pgpverify[2298]: pgpverify: verification failed
May 12 20:45:07 colo-sc-1 pgpverify[2306]: pgpverify: verification failed
May 12 20:45:07 colo-sc-1 pgpverify[2314]: pgpverify: verification failed
May 12 20:45:07 colo-sc-1 pgpverify[2322]: pgpverify: verification failed
May 12 20:45:08 colo-sc-1 pgpverify[2331]: pgpverify: verification failed
May 12 21:15:01 colo-sc-1 pgpverify[6020]: pgpverify: verification failed
May 12 21:15:01 colo-sc-1 controlchan[24102]: skipping newgroup y moderator@dana.de (pgpverify failed) in <newgroup-de.markt-2022-05-12-1@dana.de>
May 12 21:15:02 colo-sc-1 pgpverify[6028]: pgpverify: verification failed
May 12 21:15:02 colo-sc-1 controlchan[24102]: skipping newgroup y moderator@dana.de (pgpverify failed) in <newgroup-de.comm.geraete.mobil-2022-05-12-1@dana.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 13466 75.6%1.6 MB 73.0%
innd 2489 14.0%355.4 KB 15.6%
innfeed 1217 6.8%170.2 KB 7.5%
cnfsstat 576 3.2%84.4 KB 3.7%
nnrpd 30 0.2%3.2 KB 0.1%
controlchan 15 0.1%1.2 KB 0.1%
pgpverify 14 0.1%2.1 KB 0.1%
TOTAL: 7 17807 100.0%2.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 35489 42.2%
Negative hits 35460 42.2%
Do not exist 13053 15.5%
Cache misses 34 0.0%
TOTAL: 4 84036 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.361 0.0%64 0.000 5.641 17.167
article cleanup00:00:00.082 0.0%13141 0.000 0.006 0.037
article logging00:00:00.443 0.0%13403 0.000 0.033 0.094
article parse00:00:00.245 0.0%24835 0.000 0.010 0.029
article write00:00:06.277 0.0%12265 0.000 0.512 32.233
artlog/artcncl00:00:00.002 0.0%60 0.000 0.033 1.000
data move00:00:00.047 0.0%91778 0.000 0.001 0.007
hisgrep/artcncl00:00:00.001 0.0%62 0.000 0.016 0.083
hishave/artcncl00:00:00.115 0.0%64 0.000 1.797 9.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:04:22.028 0.3%84413 0.000 3.104 69.036
history sync00:00:00.020 0.0%377 0.000 0.053 0.500
history write00:00:03.824 0.0%13127 0.000 0.291 15.535
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:55:50.714 99.6%91806 553.283 938.400 4480.045
nntp read00:00:00.651 0.0%92590 0.000 0.007 0.019
overview write00:00:00.052 0.0%12265 0.000 0.004 0.031
perl filter00:00:14.347 0.0%13127 0.845 1.093 1.491
python filter00:00:00.383 0.0%13127 0.000 0.029 0.080
site send00:00:02.187 0.0%36801 0.022 0.059 0.111
TOTAL: 24:00:56.13724:00:41.779100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.017 0.0%12244 0.000 0.001 0.038
article prepare00:00:00.000 0.0%915 0.000 0.000 0.000
article read00:00:00.019 0.0%528 0.000 0.036 1.000
backlog stats00:00:00.043 0.0%70502 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.311 0.0%42039 0.000 0.007 0.023
data write00:00:00.808 0.0%30186 0.000 0.027 0.077
idle23:58:29.706100.0%70502 791.221 1224.216 4350.080
status file00:00:01.918 0.0%243 0.000 7.893 372.200
TOTAL: 23:58:34.79623:58:32.822100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.000 0.0%0 0.000 0.000 0.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%7 0.000 0.000 0.000
TOTAL: 00:00:08.49100:00:00.000 0.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 167

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de0001100
TOTAL0001100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 30 22719 7946 14663 110 34%47:36:05
2news-out.aioe.org 3 12403 3910 8130 363 31%23:51:46
3news.nntp4.net 2 13476 219 12911 346 1%24:27:24
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 36 48598 12075 35704 819 24%95:55:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net25.6 MB6.6 KB209.1 KB25.8 MB 99%3.3 KB
2news-out.aioe.org9.7 MB23.0 KB714.4 KB10.4 MB 93%2.5 KB
3news.nntp4.net866.1 KB0.0 KB2.1 MB3.0 MB 28%5.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 436.1 MB29.5 KB3.0 MB39.2 MB 92%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 12 15:00:02 - 15:59:59 731 6.0% 0.202.0 MB 5.5% 0.57
May 12 16:00:00 - 16:59:59 617 5.0% 0.171.7 MB 4.5% 0.47
May 12 17:00:00 - 17:59:59 612 5.0% 0.171.9 MB 5.1% 0.54
May 12 18:00:00 - 18:59:59 654 5.3% 0.181.9 MB 5.1% 0.54
May 12 19:00:00 - 19:59:59 679 5.5% 0.192.1 MB 5.6% 0.59
May 12 20:00:00 - 20:59:59 573 4.7% 0.161.9 MB 5.1% 0.53
May 12 21:00:00 - 21:59:59 553 4.5% 0.151.7 MB 4.6% 0.48
May 12 22:00:00 - 22:59:59 487 4.0% 0.142.1 MB 5.8% 0.61
May 12 23:00:00 - 23:59:59 379 3.1% 0.111.3 MB 3.4% 0.36
May 13 00:00:00 - 00:59:59 335 2.7% 0.091.1 MB 2.9% 0.30
May 13 01:00:00 - 01:59:59 298 2.4% 0.081.1 MB 3.1% 0.32
May 13 02:00:00 - 02:59:59 267 2.2% 0.071.1 MB 3.0% 0.32
May 13 03:00:00 - 03:59:59 193 1.6% 0.05646.8 KB 1.7% 0.18
May 13 04:00:00 - 04:59:59 234 1.9% 0.07751.6 KB 2.0% 0.21
May 13 05:00:00 - 05:59:59 350 2.9% 0.10959.4 KB 2.5% 0.27
May 13 06:00:00 - 06:59:59 415 3.4% 0.121.1 MB 3.1% 0.33
May 13 07:00:00 - 07:59:59 584 4.8% 0.161.6 MB 4.2% 0.44
May 13 08:00:00 - 08:59:59 591 4.8% 0.161.6 MB 4.3% 0.45
May 13 09:00:00 - 09:59:59 563 4.6% 0.161.5 MB 4.2% 0.44
May 13 10:00:00 - 10:59:59 607 5.0% 0.171.5 MB 4.2% 0.44
May 13 11:00:00 - 11:59:59 678 5.5% 0.191.9 MB 5.1% 0.54
May 13 12:00:00 - 12:59:59 610 5.0% 0.171.7 MB 4.5% 0.47
May 13 13:00:00 - 13:59:59 625 5.1% 0.172.0 MB 5.3% 0.56
May 13 14:00:00 - 14:59:59 616 5.0% 0.171.9 MB 5.2% 0.54
May 13 15:00:00 - 15:00:05 1 0.0% 0.203.1 KB 0.0% 0.62
TOTAL: 24:00:03 12252 100.0% 0.1436.9 MB 100.0% 0.44
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB938.7 MB 91.7% 6 0.18 65.69
ONEDEFAULT1024.0 MB89.0 MB 8.7% 9 0.18 65.73
THREEDEFAULT1024.0 MB949.4 MB 92.7% 6 0.18 66.99
TWODEFAULT1024.0 MB940.1 MB 91.8% 6 0.19 65.02
TOTAL: 4-4.0 GB2.8 GB 71.2% 27 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news-out.aioe.org 439 0 0 6 0 0 0 0 433
2news.nntp4.net 394 2 0 6 0 0 0 0 386
3hasname-out.news.weretis.net 321 1 0 2 0 0 0 0 318
TOTAL: 3 1154 3 0 14 0 0 0 0 1137

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sex.female 1
de.comm.geraete.mobil 1
list.postfix.users 1
TOTAL: 3 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 320
EMP (phn path) 311
EMP (phn nph) 162
EMP (phl) 75
Scoring filter 3
HTML file attachment 1
HTML Multipart 1
TOTAL: 7 873

INND no permission servers:

SystemConn
192.64.113.244 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 209
news-out.aioe.org 54
news.nntp4.net 1
TOTAL: 3 264
TOTAL: 1 264

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 398 398 0 0 0 0100%19:55:04
2aioe 10350 101 7845 9 0 5 0%24:00:00
3nntp4 14555 2 11975 0 0 7 0%23:55:32
4weretis 4273 1 4085 17 0 0 0%23:56:45
TOTAL: 4 29576 502 23905 26 0 12 1%91:47:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.6 MB0.0 KB1.6 MB0.0 KB/s4.2 KB19:55:04
2aioe316.5 KB37.2 KB353.7 KB0.0 KB/s3.2 KB24:00:00
3nntp45.1 KB0.0 KB5.1 KB0.0 KB/s2.5 KB23:55:32
4weretis1.9 KB73.8 KB75.7 KB0.0 KB/s4.2 KB23:56:45
TOTAL: 41.9 MB111.0 KB2.0 MB0.0 KB/s4.0 KB91:47:21
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
census9.shodan.io 0.003 0.009 0.00000:00:08
50.31.21.4 0.004 0.003 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.003 0.000 0.00000:00:00
TOTAL: 3 0.010 0.012 0.00000:00:08

NNRP no permission clients:

SystemConn
census9.shodan.io 4
50.31.21.4 2
scanner-05.ch1.censys-scanner.com 1
TOTAL: 3 7
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>