Daily Usenet report

Apr 30 04:15:01 -- May 1 04:15:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Apr 30 06:39:59 newsfeed overchan[638603]: input line too long, skipping
Apr 30 07:05:42 newsfeed nnrpd[646890]: SERVER perl filter not defined
Apr 30 07:08:52 newsfeed nnrpd[646932]: SERVER perl filter not defined
Apr 30 11:08:32 newsfeed overchan[638603]: input line too long, skipping
Apr 30 12:39:29 newsfeed overchan[638603]: input line too long, skipping
Apr 30 15:39:35 newsfeed overchan[638603]: input line too long, skipping
May 1 02:04:01 newsfeed pgpverify[698686]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn1230791 96.9%134.7 MB 96.5%
innfeed 23495 1.8%2.8 MB 2.0%
innd 8204 0.6%1.3 MB 0.9%
nnrpd 7656 0.6%858.0 KB 0.6%
controlchan 22 0.0%5.3 KB 0.0%
overchan 5 0.0%0.8 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 71270174 100.0%139.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1226540 99.3%
Negative hits 7155 0.6%
Positive hits 860 0.1%
Cache misses 83 0.0%
TOTAL: 4 1234638 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.901 0.0%128 0.000 30.477 186.875
article cleanup00:00:04.530 0.0%1242606 0.002 0.004 0.006
article logging00:00:16.647 0.0%1242879 0.009 0.013 0.036
article parse00:05:42.852 0.4%165805842 0.002 0.002 0.003
article write00:04:25.811 0.3%1241889 0.085 0.214 0.727
artlog/artcncl00:00:00.001 0.0%119 0.000 0.008 0.031
data move00:00:27.376 0.0%173767241 0.000 0.000 0.000
hisgrep/artcncl00:00:01.450 0.0%108 0.000 13.426 37.125
hishave/artcncl00:00:00.004 0.0%128 0.000 0.031 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:06:17.770 0.4%1249991 0.079 0.302 4.365
history sync00:00:00.006 0.0%292 0.000 0.021 0.500
history write00:19:04.490 1.3%1241958 0.113 0.922 13.877
hiswrite/artcncl00:00:00.005 0.0%20 0.000 0.250 0.263
idle22:23:45.850 93.3%163743656 0.298 0.492 1.111
nntp read00:15:22.741 1.1%164936746 0.005 0.006 0.007
overview write00:00:02.180 0.0%1241889 0.001 0.002 0.004
perl filter00:32:31.387 2.3%1241958 1.226 1.571 2.355
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:19.440 0.0%2492577 0.006 0.008 0.012
TOTAL: 24:00:02.07023:48:26.441 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.039 0.0%28726 0.000 0.001 0.016
article prepare00:00:00.000 0.0%3374 0.000 0.000 0.000
article read00:00:14.169 0.0%870 0.000 16.286 72.000
backlog stats00:00:00.039 0.0%74283 0.000 0.001 0.006
callbacks00:00:00.000 0.0%23 0.000 0.000 0.000
data read00:00:00.202 0.0%35213 0.000 0.006 0.030
data write00:00:00.492 0.0%26606 0.000 0.018 0.093
idle23:55:30.415100.0%74283 451.374 1159.490 3065.342
status file00:00:05.332 0.0%7588 0.133 0.703 10.267
TOTAL: 23:55:52.48323:55:50.688100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:32.328 99.1%4194 0.000 436.893600022.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.106 0.0%10146 0.000 0.010 0.500
readart00:00:00.000 0.0%8 0.000 0.000 0.000
TOTAL: 00:30:48.97600:30:32.434 99.1%----

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
bofh-control@killfile.org001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 299 12303691229661 10 698 99%121:22:27
2news.icm.edu.pl 48 285 67 197 21 23%18:01:40
3localhost 3 2 2 0 0 100%00:00:00
TOTAL: 3 350 12306561229730 207 719 99%139:24:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl329.0 GB122.2 MB122.3 MB329.2 GB 99%280.6 KB
2news.icm.edu.pl3.0 MB0.0 KB667.1 KB3.7 MB 82%42.5 KB
3localhost2.7 KB0.0 KB0.0 KB2.7 KB100%1.4 KB
TOTAL: 3329.0 GB122.2 MB122.9 MB329.2 GB 99%280.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 30 04:15:01 - 04:59:59 49969 4.1% 18.5110.1 GB 3.1%3936.60
Apr 30 05:00:00 - 05:59:59 127935 10.4% 35.5417.5 GB 5.3%5101.36
Apr 30 06:00:00 - 06:59:59 93388 7.6% 25.9415.9 GB 4.8%4640.34
Apr 30 07:00:00 - 07:59:59 58078 4.7% 16.1312.7 GB 3.9%3710.56
Apr 30 08:00:00 - 08:59:59 120246 9.8% 33.4017.6 GB 5.3%5130.95
Apr 30 09:00:00 - 09:59:59 36172 2.9% 10.0512.1 GB 3.7%3514.68
Apr 30 10:00:00 - 10:59:59 39498 3.2% 10.9713.2 GB 4.0%3846.33
Apr 30 11:00:00 - 11:59:59 32620 2.7% 9.0612.7 GB 3.8%3696.19
Apr 30 12:00:00 - 12:59:59 30384 2.5% 8.4412.4 GB 3.8%3609.89
Apr 30 13:00:00 - 13:59:59 29806 2.4% 8.2812.2 GB 3.7%3562.46
Apr 30 14:00:00 - 14:59:59 29670 2.4% 8.2412.7 GB 3.8%3690.36
Apr 30 15:00:00 - 15:59:59 30048 2.4% 8.3513.0 GB 3.9%3777.76
Apr 30 16:00:00 - 16:59:59 28483 2.3% 7.9112.5 GB 3.8%3645.49
Apr 30 17:00:00 - 17:59:59 30382 2.5% 8.4412.7 GB 3.9%3707.35
Apr 30 18:00:00 - 18:59:59 30368 2.5% 8.4412.4 GB 3.7%3598.29
Apr 30 19:00:00 - 19:59:59 32611 2.7% 9.0612.7 GB 3.8%3687.13
Apr 30 20:00:00 - 20:59:59 29028 2.4% 8.0613.0 GB 3.9%3779.62
Apr 30 21:00:00 - 21:59:59 29758 2.4% 8.2713.1 GB 4.0%3806.13
Apr 30 22:00:00 - 22:59:59 56070 4.6% 15.5714.0 GB 4.3%4086.38
Apr 30 23:00:00 - 23:59:59 124926 10.2% 34.7017.9 GB 5.4%5220.49
May 1 00:00:00 - 00:59:59 53096 4.3% 14.7514.7 GB 4.4%4272.14
May 1 01:00:00 - 01:59:59 72917 5.9% 20.2517.6 GB 5.3%5118.44
May 1 02:00:00 - 02:59:59 32662 2.7% 9.0714.0 GB 4.2%4081.64
May 1 03:00:00 - 03:59:59 25356 2.1% 7.0410.3 GB 3.1%2987.27
May 1 04:00:00 - 04:15:02 6210 0.5% 6.882.9 GB 0.9%3332.51
TOTAL: 24:00:01 1229681 100.0% 14.23329.8 GB 100.0%4002.35
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 972 50 0 648 0 0 0 0 274
2news.icm.edu.pl 19 0 0 0 0 0 0 0 19
TOTAL: 2 991 50 0 648 0 0 0 0 293

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 16
comp.mobile.android 9
it.comp.os.win.windows7 9
it.tlc.cellulari.android 5
alt.comp.software.firefox 3
alt.comp.software.seamonkey 2
it.comp.os.win.windows10 2
comp.sys.raspberry-pi 2
comp.mobile.ipad 1
de.comp.office-pakete.ms-office.excel 1
TOTAL: 10 50

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7
Binary in non-binary group 5
Scoring filter (9) 4
Scoring filter (11) 3
TOTAL: 4 19

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 20106 149 7298 204 53 21116 0%23:59:54
2icm 14538 27 8529 86 0 0 0%23:59:21
3nask 0 0 0 0 0 6232 0%23:57:47
4poznan 68 0 40 7 0 0 0%02:16:35
5okapi 0 0 0 0 0 327 0%23:57:47
TOTAL: 5 34712 176 15867 297 53 27675 0%98:11:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama541.7 KB2.0 MB2.5 MB0.0 KB/s7.3 KB23:59:54
2icm78.0 KB23.9 MB24.0 MB0.3 KB/s217.6 KB23:59:21
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4poznan0.0 KB190.1 KB190.1 KB0.0 KB/s27.2 KB02:16:35
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 5619.6 KB26.1 MB26.7 MB0.1 KB/s57.8 KB98:11:24
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 87.5 KB 4 0 000:00:09
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 87.5 KB 4 2 000:30:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1730 87.5 KB 4 2 000:00:22
2*.184.9.87.ipv4.supernova.orange.pl 1 00.0 KB 0 0 000:30:00
3unresolved 104 00.0 KB 0 0 000:00:14
4*.dynamic.chello.pl 1 00.0 KB 0 0 000:00:01
5*.pol.lublin.pl 2 00.0 KB 0 0 000:00:11
TOTAL: 51838 87.5 KB 4 2 000:30:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
79.184.9.87.ipv4.supernova.orange.pl 0.018 0.009 0.00000:30:00
nms2.man.lodz.pl 2.321 11.170 0.00000:00:12
mat.pol.lublin.pl 0.000 0.019 0.00000:00:11
107.155.60.213 0.004 0.013 0.00000:00:10
web.man.lodz.pl 0.531 2.326 0.00000:00:09
80.111.142.213 0.004 0.040 0.00000:00:02
89-64-85-205.dynamic.chello.pl 0.003 0.006 0.00000:00:01
212.51.192.185 0.158 0.706 0.00000:00:00
104.236.128.19 0.002 0.007 0.00000:00:00
198.140.141.135 0.000 0.009 0.00000:00:00
isvcs01.man.lodz.pl 0.003 0.021 0.00000:00:00
TOTAL: 11 3.044 14.326 0.00000:30:49

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
mat.pol.lublin.pl 2
107.155.60.213 2
89-64-85-205.dynamic.chello.pl 1
104.236.128.19 1
79.184.9.87.ipv4.supernova.orange.pl 1
198.140.141.135 1
TOTAL: 9 1548

NNRP unrecognized commands (by host):

SystemConn
107.155.60.213 3
104.236.128.19 1
TOTAL: 2 4

NNRP unrecognized commands (by command):

CommandCount
#023#003#023#001#023#002#001 1
MGLNDD_212.191.2.21_119 1
Dw#023¼Ä®#025_g¦Ã« 1
#026#003#001#001#011#001 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
79.184.9.87.ipv4.supernova.orange.pl 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 8100.0%
TOTAL: 1 8100.0%

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

NewsgroupCount
1pl.comp.pecet 8
TOTAL: 1 8