Daily Usenet report

Dec 1 04:15:03 -- Dec 2 04:15:03

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Dec 1 04:20:48 newsfeed nnrpd[18502]: mon.man.lodz.pl rejected Expiring process 18450
Dec 1 08:22:57 newsfeed nnrpd[27392]: SERVER perl filter not defined
Dec 1 10:42:01 newsfeed nnrpd[32091]: SERVER perl filter not defined
Dec 1 14:50:35 newsfeed overchan[18174]: input line too long, skipping
Dec 1 16:45:03 newsfeed pgpverify[11892]: pgpverify: verification failed
Dec 1 16:45:09 newsfeed nnrpd[11913]: SERVER perl filter not defined
Dec 1 17:20:29 newsfeed overchan[18174]: input line too long, skipping
Dec 1 18:59:19 newsfeed overchan[18174]: input line too long, skipping
Dec 1 20:43:59 newsfeed overchan[18174]: input line too long, skipping
Dec 1 21:37:29 newsfeed nnrpd[21827]: SERVER perl filter not defined
Dec 1 22:25:10 newsfeed overchan[18174]: input line too long, skipping
Dec 2 00:06:59 newsfeed overchan[18174]: input line too long, skipping
Dec 2 00:41:40 newsfeed overchan[18174]: input line too long, skipping
Dec 2 02:05:35 newsfeed overchan[18174]: input line too long, skipping
Dec 2 02:58:17 newsfeed overchan[18174]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn3150066 98.3%364.9 MB 98.1%
innfeed 26130 0.8%3.1 MB 0.8%
innd 22332 0.7%3.6 MB 1.0%
nnrpd 4859 0.2%516.7 KB 0.1%
overchan 10 0.0%1.9 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 73203402 100.0%372.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3125188 97.4%
Negative hits 63081 2.0%
Positive hits 19649 0.6%
Cache misses 207 0.0%
TOTAL: 4 3208125 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.734 0.0%45 0.000 105.200 686.000
article cleanup00:00:38.942 0.0%3147627 0.009 0.012 0.017
article logging00:02:20.586 0.2%3148092 0.032 0.045 2.258
article parse00:48:47.079 3.4%90778454 0.018 0.032 0.047
article write00:19:22.444 1.3%3139428 0.193 0.370 4.475
artlog/artcncl00:00:00.004 0.0%44 0.000 0.091 0.500
artlog/artparse00:00:00.000 0.0%5 0.000 0.000 0.000
data move00:02:45.680 0.2%106948660 0.001 0.002 0.004
hisgrep/artcncl00:00:00.322 0.0%44 0.000 7.318 44.000
hishave/artcncl00:00:00.106 0.0%45 0.000 2.356 24.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:45:36.652 7.3%3227450 0.311 1.963 21.098
history sync00:00:00.018 0.0%290 0.000 0.062 1.000
history write03:52:37.587 16.2%3142163 1.125 4.442 70.083
hiswrite/artcncl00:00:00.006 0.0%1 6.000 6.000 6.000
idle10:35:39.091 44.1%57817017 0.219 0.660 1.817
nntp read01:03:09.303 4.4%88221016 0.033 0.043 0.063
overview write00:00:15.747 0.0%3139428 0.003 0.005 0.007
perl filter04:55:07.411 20.5%3142155 3.681 5.635 7.546
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:06:19.304 0.4%6312985 0.041 0.060 0.074
TOTAL: 24:00:02.13423:32:45.016 98.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.237 0.0%79676 0.000 0.003 0.012
article prepare00:00:00.009 0.0%35972 0.000 0.000 0.028
article read00:00:47.121 0.1%8965 0.000 5.256 710.500
backlog stats00:00:00.218 0.0%245759 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.636 0.0%132031 0.006 0.020 0.038
data write00:00:19.001 0.0%118122 0.036 0.161 0.304
idle23:52:55.495 99.8%245759 24.177 349.837 1687.393
status file00:01:02.247 0.1%9063 0.000 6.868 736.161
TOTAL: 23:55:19.54423:55:06.964100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:29.296 64.5%3020 0.000 9.701 1650.889
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.526 1.2%6628 0.000 0.079 3.421
readart00:00:00.003 0.0%12 0.000 0.250 0.500
TOTAL: 00:00:45.39700:00:29.825 65.7%----

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 852 31415823137063 1138 3381 99%489:53:23
2news.nask.pl 2 21716 3947 13056 4713 18%23:29:02
3news.icm.edu.pl 43 329 62 200 67 18%16:26:26
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 902 31636313141076 14394 8161 99%529:48:51
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl782.5 GB39.8 MB144.5 MB782.7 GB 99%261.3 KB
2news.nask.pl66.2 MB190.8 MB205.3 MB462.3 MB 14%54.7 KB
3news.icm.edu.pl1.5 MB10.8 KB2.5 MB4.0 MB 36%31.8 KB
4localhost5.9 KB0.0 KB0.0 KB5.9 KB100%1.5 KB
TOTAL: 4782.6 GB230.6 MB352.3 MB783.1 GB 99%260.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 1 04:15:03 - 04:59:59 92185 2.9% 34.1829.0 GB 3.7%11266.91
Dec 1 05:00:00 - 05:59:59 125858 4.0% 34.9636.9 GB 4.7%10757.55
Dec 1 06:00:00 - 06:59:59 122794 3.9% 34.1138.1 GB 4.9%11099.60
Dec 1 07:00:00 - 07:59:59 90106 2.9% 25.0329.9 GB 3.8%8719.48
Dec 1 08:00:00 - 08:59:59 106655 3.4% 29.6330.9 GB 3.9%8988.97
Dec 1 09:00:00 - 09:59:59 138309 4.4% 38.4231.4 GB 4.0%9152.58
Dec 1 10:00:00 - 10:59:59 161532 5.1% 44.8737.1 GB 4.7%10792.09
Dec 1 11:00:00 - 11:59:59 130822 4.2% 36.3429.2 GB 3.7%8498.23
Dec 1 12:00:00 - 12:59:59 145573 4.6% 40.4434.4 GB 4.4%10024.27
Dec 1 13:00:00 - 13:59:59 108847 3.5% 30.2431.3 GB 4.0%9109.23
Dec 1 14:00:00 - 14:59:59 77850 2.5% 21.6225.1 GB 3.2%7315.46
Dec 1 15:00:00 - 15:59:59 93162 3.0% 25.8830.3 GB 3.9%8827.45
Dec 1 16:00:00 - 16:59:59 154747 4.9% 42.9936.4 GB 4.6%10594.40
Dec 1 17:00:00 - 17:59:59 160572 5.1% 44.6039.8 GB 5.1%11578.64
Dec 1 18:00:00 - 18:59:59 167595 5.3% 46.5541.9 GB 5.4%12199.56
Dec 1 19:00:00 - 19:59:59 156167 5.0% 43.3840.9 GB 5.2%11922.11
Dec 1 20:00:00 - 20:59:59 190598 6.1% 52.9440.0 GB 5.1%11651.07
Dec 1 21:00:00 - 21:59:59 172988 5.5% 48.0536.4 GB 4.6%10597.87
Dec 1 22:00:00 - 22:59:59 132853 4.2% 36.9031.7 GB 4.0%9219.92
Dec 1 23:00:00 - 23:59:59 127405 4.1% 35.3936.3 GB 4.6%10559.10
Dec 2 00:00:00 - 00:59:59 92270 2.9% 25.6324.7 GB 3.2%7190.17
Dec 2 01:00:00 - 01:59:59 128354 4.1% 35.6522.3 GB 2.8%6488.40
Dec 2 02:00:00 - 02:59:59 107587 3.4% 29.8920.6 GB 2.6%6001.62
Dec 2 03:00:00 - 03:59:59 120156 3.8% 33.3821.4 GB 2.7%6229.80
Dec 2 04:00:00 - 04:15:03 36371 1.2% 40.286.8 GB 0.9%7858.66
TOTAL: 24:00:00 3141356 100.0% 36.36782.5 GB 100.0%9497.07
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4853 2 0 2860 3 0 0 0 1988
2newsfeed.pionier.net.pl 3746 154 0 2607 5 0 0 0 980
3news.icm.edu.pl 67 0 0 1 0 0 0 0 66
TOTAL: 3 8666 156 0 5468 8 0 0 0 3034

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 79
it.comp.os.win.windows10 31
it.tlc.cellulari.android 21
nl.comp.os.linux.techniek 9
comp.mobile.android 7
it.comp.os.win.windows7 2
nl.wetenschap.regulier 1
nl.comp.sys.android 1
nl.gezondheid.alternatief-genezen 1
de.rec.kunst 1
alt.sex.telephones 1
nl.comp.3d-printen 1
nl.actueel 1
TOTAL: 13 156

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

GroupsCount
pl.praca.oferowana 4
pl.sci.matematyka 3
bit.listserv.catholic 1
TOTAL: 3 8

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1774
Binary in non-binary group 672
Scoring filter (16) 50
EMP (phl) 25
Scoring filter (8) 17
Too many newsgroups 6
Scoring filter (9) 4
Poison newsgroup 4
EMP (fsl) 3
Scoring filter (10) 2
Scoring filter (11) 2
HTML post 2
Scoring filter (18) 1
Scoring filter (12) 1
TOTAL: 14 2563

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 1
TOTAL: 1 1
Including strange strings
newsfeed.pionier.net.pl 366
news.nask.pl 97
TOTAL: 2 463
TOTAL: 2 464

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 31500 8118 16406 220 0 1434 25%23:59:58
2panorama 47430 264 32134 49 0 45909 0%23:59:58
3icm 36588 66 33321 106 0 0 0%23:59:23
4poznan 5282 50 3832 33 0 1 0%23:59:46
5okapi 0 0 0 0 0 1018 0%23:57:51
TOTAL: 5 120800 8498 85693 408 0 48362 7%119:56:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask3.0 GB82.9 MB3.1 GB37.6 KB/s389.2 KB23:59:58
2icm3.9 MB31.9 MB35.8 MB0.4 KB/s213.2 KB23:59:23
3panorama869.6 KB780.0 KB1.6 MB0.0 KB/s5.3 KB23:59:58
4poznan188.2 KB253.0 KB441.2 KB0.0 KB/s5.3 KB23:59:46
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 53.0 GB115.8 MB3.1 GB7.6 KB/s368.8 KB119:56:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 129.8 KB 6 0 000:00:35
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 129.8 KB 6 4 000:00:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 581 129.8 KB 6 4 000:00:42
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3unresolved 96 00.0 KB 0 0 000:00:01
TOTAL: 3 678 129.8 KB 6 4 000:00:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.492 5.884 0.00000:00:35
mon.man.lodz.pl 1.284 4.972 0.00000:00:05
212.51.192.185 0.412 1.548 0.00000:00:01
scan-141.security.ipip.net 0.008 0.020 0.00000:00:00
isvcs01.man.lodz.pl 0.024 0.116 0.00000:00:00
TOTAL: 5 3.220 12.540 0.00000:00:44

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 289
212.51.192.185 96
scan-141.security.ipip.net 1
TOTAL: 3 386

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
User-Agent: HTTP Banner Detection (https... 1
Connection: close 1
GET / HTTP/1.1 1
Host: 212.191.2.21:119 1
TOTAL: 4 4

NNRP client timeouts [Top 20]:

SystemConnPeer
scan-141.security.ipip.net 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

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