Daily Usenet report

Sep 1 04:15:02 -- Sep 2 04:15:04

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Sep 1 07:37:26 newsfeed overchan[554]: input line too long, skipping
Sep 1 10:37:32 newsfeed nnrpd[15203]: SERVER perl filter not defined
Sep 1 11:30:02 newsfeed pgpverify[17196]: pgpverify: verification failed
Sep 1 15:51:35 newsfeed overchan[554]: input line too long, skipping
Sep 1 16:03:28 newsfeed overchan[554]: input line too long, skipping
Sep 1 16:10:54 newsfeed overchan[554]: input line too long, skipping
Sep 1 16:13:42 newsfeed overchan[554]: input line too long, skipping
Sep 1 16:14:49 newsfeed overchan[554]: input line too long, skipping
Sep 1 16:21:09 newsfeed overchan[554]: input line too long, skipping
Sep 1 16:23:41 newsfeed overchan[554]: input line too long, skipping
Sep 1 16:24:31 newsfeed overchan[554]: input line too long, skipping
Sep 1 19:58:06 newsfeed overchan[554]: input line too long, skipping
Sep 1 20:14:13 newsfeed overchan[554]: input line too long, skipping
Sep 1 20:35:43 newsfeed overchan[554]: input line too long, skipping
Sep 1 20:41:11 newsfeed overchan[554]: input line too long, skipping
Sep 1 22:24:23 newsfeed nnrpd[14299]: SERVER perl filter not defined
Sep 2 02:56:29 newsfeed overchan[554]: input line too long, skipping
Sep 2 03:54:43 newsfeed overchan[554]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2851968 97.5%333.3 MB 97.2%
innfeed 45620 1.6%5.3 MB 1.6%
innd 23542 0.8%3.7 MB 1.1%
nnrpd 4777 0.2%501.7 KB 0.1%
overchan 16 0.0%3.0 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 72925928 100.0%342.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2833968 96.7%
Negative hits 84977 2.9%
Positive hits 12201 0.4%
Cache misses 126 0.0%
TOTAL: 4 2931272 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.965 0.0%203 0.000 24.458 1703.000
article cleanup00:00:44.497 0.1%2851087 0.009 0.016 0.022
article logging00:02:00.053 0.1%2851726 0.027 0.042 0.144
article parse01:16:04.955 5.3%177680169 0.017 0.026 0.037
article write00:25:23.522 1.8%2843599 0.101 0.536 1.236
artlog/artcncl00:00:00.007 0.0%203 0.000 0.034 1.000
data move00:04:23.852 0.3%194731998 0.001 0.001 0.003
hisgrep/artcncl00:00:00.960 0.0%198 0.000 4.848 138.000
hishave/artcncl00:00:00.040 0.0%203 0.000 0.197 3.556
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:24:47.268 1.7%2947514 0.015 0.505 4.496
history sync00:00:00.017 0.0%290 0.000 0.059 1.000
history write01:19:52.865 5.5%2847969 0.102 1.683 8.997
hiswrite/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
idle11:51:48.677 49.4%120890560 0.203 0.353 0.799
nntp read01:38:12.480 6.8%175498777 0.022 0.034 0.053
overview write00:00:17.153 0.0%2843599 0.004 0.006 0.009
perl filter06:11:45.888 25.8%2847969 1.667 7.832 9.939
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:19.295 0.4%5709016 0.042 0.056 0.081
TOTAL: 24:00:01.67723:20:46.494 97.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.199 0.0%64320 0.000 0.003 0.012
article prepare00:00:00.005 0.0%10362 0.000 0.000 0.036
article read00:01:24.409 0.1%2589 0.000 32.603 693.875
backlog stats00:00:00.183 0.0%180776 0.000 0.001 0.005
callbacks00:00:00.000 0.0%16 0.000 0.000 0.000
data read00:00:02.671 0.0%96464 0.009 0.028 0.072
data write00:00:04.328 0.0%76091 0.027 0.057 0.227
idle23:51:28.084 99.8%180776 310.098 475.108 1006.713
status file00:00:19.366 0.0%16097 0.664 1.203 18.779
TOTAL: 23:53:37.40623:53:19.245100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:21.432 54.1%3041 0.000 7.048 242.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.193 0.5%6753 0.000 0.029 0.500
readart00:00:00.003 0.0%44 0.000 0.068 1.000
TOTAL: 00:00:39.57900:00:21.628 54.6%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 192

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1099 28427922832746 6990 3056 99%380:28:32
2news.nask.pl 2 16933 10754 1811 4368 63%24:12:17
3news.icm.edu.pl 40 376 44 284 48 11%19:42:06
4localhost 3 2 2 0 0 100%00:00:00
TOTAL: 4 1144 28601032843546 9085 7472 99%424:22:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl859.9 GB36.4 MB36.8 MB860.0 GB 99%318.0 KB
2news.nask.pl70.1 MB522.4 KB24.3 MB95.0 MB 73%6.4 KB
3news.icm.edu.pl1.0 MB0.0 KB3.1 MB4.1 MB 24%45.5 KB
4localhost3.5 KB0.0 KB0.0 KB3.5 KB100%1.8 KB
TOTAL: 4860.0 GB36.9 MB64.2 MB860.1 GB 99%316.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 1 04:15:02 - 04:59:59 73164 2.6% 27.1229.0 GB 3.4%11276.17
Sep 1 05:00:00 - 05:59:59 95077 3.3% 26.4137.3 GB 4.3%10851.19
Sep 1 06:00:00 - 06:59:59 113478 4.0% 31.5242.2 GB 4.9%12298.19
Sep 1 07:00:00 - 07:59:59 124952 4.4% 34.7142.3 GB 4.9%12321.99
Sep 1 08:00:00 - 08:59:59 126989 4.5% 35.2741.7 GB 4.9%12158.39
Sep 1 09:00:00 - 09:59:59 127924 4.5% 35.5339.9 GB 4.6%11626.42
Sep 1 10:00:00 - 10:59:59 281826 9.9% 78.2829.9 GB 3.5%8723.16
Sep 1 11:00:00 - 11:59:59 119268 4.2% 33.1333.2 GB 3.9%9662.00
Sep 1 12:00:00 - 12:59:59 120637 4.2% 33.5139.4 GB 4.6%11465.71
Sep 1 13:00:00 - 13:59:59 118991 4.2% 33.0539.8 GB 4.6%11589.51
Sep 1 14:00:00 - 14:59:59 111790 3.9% 31.0537.2 GB 4.3%10830.98
Sep 1 15:00:00 - 15:59:59 135213 4.8% 37.5640.0 GB 4.7%11664.13
Sep 1 16:00:00 - 16:59:59 116840 4.1% 32.4639.9 GB 4.6%11617.58
Sep 1 17:00:00 - 17:59:59 85698 3.0% 23.8026.4 GB 3.1%7677.86
Sep 1 18:00:00 - 18:59:59 53682 1.9% 14.9118.0 GB 2.1%5241.34
Sep 1 19:00:00 - 19:59:59 121259 4.3% 33.6838.5 GB 4.5%11215.52
Sep 1 20:00:00 - 20:59:59 104172 3.7% 28.9436.1 GB 4.2%10517.92
Sep 1 21:00:00 - 21:59:59 118547 4.2% 32.9337.5 GB 4.4%10924.51
Sep 1 22:00:00 - 22:59:59 135727 4.8% 37.7040.9 GB 4.8%11913.98
Sep 1 23:00:00 - 23:59:59 128070 4.5% 35.5836.8 GB 4.3%10713.12
Sep 2 00:00:00 - 00:59:59 84598 3.0% 23.5023.7 GB 2.8%6915.61
Sep 2 01:00:00 - 01:59:59 110840 3.9% 30.7935.5 GB 4.1%10329.71
Sep 2 02:00:00 - 02:59:59 102823 3.6% 28.5631.8 GB 3.7%9270.80
Sep 2 03:00:00 - 03:59:59 107224 3.8% 29.7833.8 GB 3.9%9855.54
Sep 2 04:00:00 - 04:15:04 24847 0.9% 27.498.2 GB 0.9%9464.28
TOTAL: 24:00:02 2843636 100.0% 32.91859.0 GB 100.0%10425.28
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4729 42 0 186 3 0 0 0 4498
2newsfeed.pionier.net.pl 3349 83 0 2932 3 0 0 0 331
3news.icm.edu.pl 51 0 0 0 0 0 0 0 51
TOTAL: 3 8129 125 0 3118 6 0 0 0 4880

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 56
comp.mobile.android 53
it.tlc.cellulari.android 7
it.comp.os.linux.ubuntu 3
uk.rec.cycling.moderated 2
comp.sys.raspberry-pi 2
hr.sci.med 1
it.comp.os.win.windows10 1
TOTAL: 8 125

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

GroupsCount
pl.praca.oferowana 5
bit.listserv.catholic 1
TOTAL: 2 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 4023
Binary in non-binary group 91
Scoring filter (9) 53
Scoring filter (8) 36
EMP (phl) 19
Scoring filter (11) 6
Scoring filter (10) 4
Too many newsgroups 3
Poison newsgroup 2
Scoring filter (12) 2
EMP (fsl) 1
Scoring filter (18) 1
TOTAL: 12 4241

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nask.pl 346
newsfeed.pionier.net.pl 293
TOTAL: 2 639
TOTAL: 1 639

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 47605 668 19780 290 37 43825 1%23:59:59
2poznan 17493 484 10040 77 0 0 2%23:59:59
3icm 26817 98 20226 430 0 0 0%23:59:59
4nask 4208 5 3083 0 0 0 0%23:54:27
5okapi 0 0 0 0 0 1934 0%23:57:52
TOTAL: 5 96123 1255 53129 797 37 45759 1%119:52:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama2.0 MB892.2 KB2.9 MB0.0 KB/s3.0 KB23:59:59
2poznan1.9 MB390.3 KB2.2 MB0.0 KB/s4.1 KB23:59:59
3icm1022.8 KB158.7 MB159.7 MB1.9 KB/s309.7 KB23:59:59
4nask9.7 KB0.0 KB9.7 KB0.0 KB/s1.9 KB23:54:27
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
TOTAL: 54.9 MB159.9 MB164.8 MB0.4 KB/s82.2 KB119:52:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4443.2 KB 21 0 000:00:28
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:01
TOTAL: 2 290 4443.2 KB 21 2 000:00:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 674 4443.2 KB 21 2 000:00:36
2*.snarked.org 2 00.0 KB 0 0 000:00:02
3*.us-west-2.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 677 4443.2 KB 21 2 000:00:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.436 5.056 0.00000:00:28
mon.man.lodz.pl 1.364 5.072 0.00000:00:04
david.man.lodz.pl 0.400 1.648 0.00000:00:02
news.snarked.org 0.036 0.052 0.00000:00:02
isvcs01.man.lodz.pl 0.012 0.052 0.00000:00:01
ec2-52-34-15-86.us-west-2.compute.amazonaws.com 0.004 0.024 0.00000:00:00
? 0.004 0.016 0.00000:00:00
TOTAL: 7 3.256 11.920 0.00000:00:38

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
news.snarked.org 2
ec2-52-34-15-86.us-west-2.compute.amazonaws.com 1
TOTAL: 4 387

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 44100.0%
TOTAL: 1 44100.0%

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

NewsgroupCount
1pl.comp.pecet 34
2pl.comp.os.ms-windows.winnt 10
TOTAL: 2 44
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>