Daily Usenet report

Apr 23 04:15:02 -- Apr 24 04:15:02

Unknown entries from news log file:

First 21 / 21 lines (100.0%)

Apr 23 07:45:04 newsfeed pgpverify[3204]: pgpverify: verification failed
Apr 23 07:48:22 newsfeed overchan[27053]: input line too long, skipping
Apr 23 07:49:15 newsfeed overchan[27053]: input line too long, skipping
Apr 23 07:52:24 newsfeed overchan[27053]: input line too long, skipping
Apr 23 11:01:50 newsfeed overchan[27053]: input line too long, skipping
Apr 23 16:16:06 newsfeed overchan[27053]: input line too long, skipping
Apr 23 16:22:50 newsfeed overchan[27053]: input line too long, skipping
Apr 23 16:33:47 newsfeed overchan[27053]: input line too long, skipping
Apr 23 16:38:51 newsfeed overchan[27053]: input line too long, skipping
Apr 23 17:07:55 newsfeed overchan[27053]: input line too long, skipping
Apr 23 17:24:05 newsfeed overchan[27053]: input line too long, skipping
Apr 23 18:10:36 newsfeed overchan[27053]: input line too long, skipping
Apr 23 18:53:04 newsfeed overchan[27053]: input line too long, skipping
Apr 23 18:53:55 newsfeed overchan[27053]: input line too long, skipping
Apr 23 18:56:05 newsfeed overchan[27053]: input line too long, skipping
Apr 23 20:45:43 newsfeed overchan[27053]: input line too long, skipping
Apr 23 21:11:03 newsfeed nnrpd[1580]: SERVER perl filter not defined
Apr 23 21:15:12 newsfeed nnrpd[1668]: SERVER perl filter not defined
Apr 23 21:16:48 newsfeed nnrpd[1844]: SERVER perl filter not defined
Apr 23 23:08:38 newsfeed overchan[27053]: input line too long, skipping
Apr 24 03:26:51 newsfeed overchan[27053]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2931897 97.6%326.6 MB 97.2%
innfeed 45581 1.5%5.4 MB 1.6%
innd 19575 0.7%3.2 MB 1.0%
nnrpd 5932 0.2%650.9 KB 0.2%
overchan 18 0.0%3.3 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 73003006 100.0%335.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2916880 96.7%
Negative hits 87728 2.9%
Positive hits 11237 0.4%
Cache misses 134 0.0%
TOTAL: 4 3015979 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:07.331 0.0%286 0.000 25.633 217.800
article cleanup00:00:29.986 0.0%2931171 0.007 0.010 0.014
article logging00:01:44.928 0.1%2931794 0.026 0.036 0.100
article parse00:33:56.796 2.4%94110035 0.014 0.022 0.034
article write00:15:40.409 1.1%2924484 0.192 0.322 0.650
artlog/artcncl00:00:00.002 0.0%285 0.000 0.007 0.100
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:02:03.794 0.1%109537981 0.000 0.001 0.002
hisgrep/artcncl00:00:03.566 0.0%234 0.000 15.239 179.133
hishave/artcncl00:00:01.428 0.0%286 0.000 4.993 74.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:39:34.818 2.7%3027786 0.028 0.784 5.357
history sync00:00:00.012 0.0%290 0.000 0.041 0.500
history write02:03:33.751 8.6%2927583 0.183 2.532 8.661
hiswrite/artcncl00:00:00.238 0.0%52 0.000 4.577 189.000
idle15:42:43.029 65.5%76716913 0.459 0.737 2.427
nntp read00:44:10.711 3.1%91871740 0.020 0.029 0.045
overview write00:00:12.339 0.0%2924484 0.002 0.004 0.005
perl filter03:33:38.175 14.8%2927582 2.757 4.378 6.150
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:33.689 0.3%5867776 0.034 0.047 0.063
TOTAL: 24:00:03.28923:42:35.002 98.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.120 0.0%58888 0.000 0.002 0.008
article prepare00:00:00.000 0.0%8836 0.000 0.000 0.000
article read00:00:18.578 0.0%2208 0.000 8.414 121.200
backlog stats00:00:00.119 0.0%173066 0.000 0.001 0.005
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:01.133 0.0%90147 0.002 0.013 0.028
data write00:00:03.185 0.0%71750 0.020 0.044 0.137
idle23:54:03.855 99.9%173066 318.585 497.174 909.632
status file00:00:15.710 0.0%16842 0.402 0.933 11.111
TOTAL: 23:54:57.25323:54:42.700100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle19:30:30.415 99.9%378129 0.000 185.731 9707.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:18.109 0.0%757190 0.000 0.024 0.667
readart00:00:00.019 0.0%42 0.000 0.452 8.500
TOTAL: 19:31:19.74119:30:48.543100.0%----

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 296 29238602914874 5184 3802 99%201:41:49
2news.nask.pl 3 14340 9125 2303 2912 63%24:16:01
3news.icm.edu.pl 53 186 12 172 2 6%15:18:57
4localhost 4 3 3 0 0 100%00:00:00
TOTAL: 4 356 29383892924014 7659 6716 99%241:16:47
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl687.7 GB19.1 MB49.7 MB687.8 GB 99%247.1 KB
2news.nask.pl32.8 MB512.7 KB21.0 MB54.3 MB 60%4.6 KB
3news.icm.edu.pl204.6 KB0.0 KB20.9 KB225.5 KB 90%16.1 KB
4localhost4.6 KB0.0 KB0.0 KB4.6 KB100%1.5 KB
TOTAL: 4687.8 GB19.6 MB70.7 MB687.9 GB 99%246.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 23 04:15:02 - 04:59:59 63350 2.2% 23.4817.6 GB 2.6%6832.04
Apr 23 05:00:00 - 05:59:59 110714 3.8% 30.7527.5 GB 4.0%8008.05
Apr 23 06:00:00 - 06:59:59 121405 4.2% 33.7230.3 GB 4.4%8821.44
Apr 23 07:00:00 - 07:59:59 105164 3.6% 29.2130.8 GB 4.5%8969.64
Apr 23 08:00:00 - 08:59:59 118722 4.1% 32.9834.4 GB 5.0%10006.19
Apr 23 09:00:00 - 09:59:59 121554 4.2% 33.7736.3 GB 5.3%10566.36
Apr 23 10:00:00 - 10:59:59 119261 4.1% 33.1334.7 GB 5.0%10121.55
Apr 23 11:00:00 - 11:59:59 131285 4.5% 36.4735.2 GB 5.1%10258.06
Apr 23 12:00:00 - 12:59:59 119945 4.1% 33.3234.0 GB 4.9%9896.56
Apr 23 13:00:00 - 13:59:59 157116 5.4% 43.6434.9 GB 5.1%10162.56
Apr 23 14:00:00 - 14:59:59 117146 4.0% 32.5433.0 GB 4.8%9610.29
Apr 23 15:00:00 - 15:59:59 58681 2.0% 16.3017.9 GB 2.6%5204.92
Apr 23 16:00:00 - 16:59:59 70015 2.4% 19.4517.0 GB 2.5%4965.99
Apr 23 17:00:00 - 17:59:59 34156 1.2% 9.499.7 GB 1.4%2820.68
Apr 23 18:00:00 - 18:59:59 81381 2.8% 22.6114.3 GB 2.1%4179.07
Apr 23 19:00:00 - 19:59:59 141566 4.8% 39.3227.7 GB 4.0%8073.09
Apr 23 20:00:00 - 20:59:59 178448 6.1% 49.5734.5 GB 5.0%10053.90
Apr 23 21:00:00 - 21:59:59 114592 3.9% 31.8326.3 GB 3.8%7672.50
Apr 23 22:00:00 - 22:59:59 152582 5.2% 42.3833.3 GB 4.8%9705.11
Apr 23 23:00:00 - 23:59:59 162675 5.6% 45.1933.3 GB 4.8%9704.69
Apr 24 00:00:00 - 00:59:59 133860 4.6% 37.1824.9 GB 3.6%7255.22
Apr 24 01:00:00 - 01:59:59 161797 5.5% 44.9432.2 GB 4.7%9387.45
Apr 24 02:00:00 - 02:59:59 185843 6.4% 51.6234.1 GB 4.9%9925.92
Apr 24 03:00:00 - 03:59:59 129435 4.4% 35.9527.8 GB 4.0%8102.64
Apr 24 04:00:00 - 04:15:02 33608 1.1% 37.267.0 GB 1.0%8192.77
TOTAL: 24:00:00 2924301 100.0% 33.85688.9 GB 100.0%8360.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4253 160 0 3399 2 0 0 0 692
2news.nask.pl 3056 50 0 190 3 0 0 0 2813
3news.icm.edu.pl 2 0 0 0 0 0 0 0 2
TOTAL: 3 7311 210 0 3589 5 0 0 0 3507

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 100
comp.sys.raspberry-pi 55
it.tlc.cellulari.android 27
it.comp.os.win.windows10 18
comp.mobile.android 7
uk.rec.cycling.moderated 2
it.politica.m5s 1
TOTAL: 7 210

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

GroupsCount
pl.sci.matematyka 4
bit.listserv.catholic 1
TOTAL: 2 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 2451
Binary in non-binary group 353
Scoring filter (8) 20
HTML post 13
Scoring filter (9) 13
EMP (fsl) 8
Scoring filter (10) 7
Scoring filter (18) 6
Scoring filter (16) 6
Too many newsgroups 4
Scoring filter (12) 1
Attached HTML file 1
TOTAL: 12 2883

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 440
news.nask.pl 183
TOTAL: 2 623
TOTAL: 1 623

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 44618 697 15693 176 7 42502 1%23:59:58
2poznan 15117 402 8610 16 1 0 2%23:59:57
3icm 26142 61 18240 332 0 0 0%23:59:58
4nask 4988 10 3364 0 0 0 0%23:59:58
5okapi 0 0 0 0 0 1008 0%23:57:50
TOTAL: 5 90865 1170 45907 524 8 43510 1%119:57:41
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm8.9 MB121.9 MB130.8 MB1.6 KB/s340.9 KB23:59:58
2panorama1.9 MB521.5 KB2.4 MB0.0 KB/s2.8 KB23:59:58
3poznan1.6 MB57.5 KB1.7 MB0.0 KB/s4.1 KB23:59:57
4nask38.2 KB0.0 KB38.2 KB0.0 KB/s3.8 KB23:59:58
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 512.4 MB122.5 MB134.9 MB0.3 KB/s81.6 KB119:57:41
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4236.3 KB 19 0 000:00:22
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 2 291 4236.3 KB 19 3 019:31:19

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 963 4236.3 KB 19 3 000:00:29
2unresolved 2 00.0 KB 0 0 019:30:49
TOTAL: 2 965 4236.3 KB 19 3 019:31:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.193.156 18.368 30.080 0.00019:27:03
89.38.40.54 0.068 0.108 0.00000:03:36
web.man.lodz.pl 1.220 2.712 0.00000:00:22
107.170.236.113 0.004 0.020 0.00000:00:09
mon.man.lodz.pl 2.016 5.088 0.00000:00:05
david.man.lodz.pl 0.292 0.796 0.00000:00:00
isvcs01.man.lodz.pl 0.012 0.024 0.00000:00:00
TOTAL: 7 21.980 38.828 0.00019:31:19

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 576
david.man.lodz.pl 96
89.38.40.54 1
107.170.236.113 1
TOTAL: 4 674

NNRP client timeouts [Top 20]:

SystemConnPeer
185.48.193.156 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 42100.0%
TOTAL: 1 42100.0%

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

NewsgroupCount
1pl.comp.pecet 22
2pl.comp.os.ms-windows.winnt 20
TOTAL: 2 42