Daily Usenet report

Oct 23 04:15:02 -- Oct 24 04:15:03

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Oct 23 10:49:58 newsfeed nnrpd[11738]: SERVER perl filter not defined
Oct 23 11:07:54 newsfeed nnrpd[12467]: SERVER perl filter not defined
Oct 23 18:14:42 newsfeed nnrpd[29241]: SERVER perl filter not defined
Oct 23 18:15:06 newsfeed nnrpd[29295]: SERVER perl filter not defined
Oct 23 18:28:12 newsfeed overchan[28599]: input line too long, skipping
Oct 23 18:32:50 newsfeed overchan[28599]: input line too long, skipping
Oct 23 18:34:00 newsfeed overchan[28599]: input line too long, skipping
Oct 23 18:36:53 newsfeed overchan[28599]: input line too long, skipping
Oct 23 18:42:34 newsfeed overchan[28599]: input line too long, skipping
Oct 23 19:45:28 newsfeed overchan[28599]: input line too long, skipping
Oct 23 19:52:53 newsfeed overchan[28599]: input line too long, skipping
Oct 23 19:56:17 newsfeed overchan[28599]: input line too long, skipping
Oct 23 20:56:45 newsfeed overchan[28599]: input line too long, skipping
Oct 23 21:45:03 newsfeed nnrpd[5085]: SERVER perl filter not defined
Oct 23 22:21:52 newsfeed overchan[28599]: input line too long, skipping
Oct 24 00:11:34 newsfeed nnrpd[31508]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2847199 97.7%323.9 MB 97.4%
innfeed 43110 1.5%5.1 MB 1.5%
innd 18301 0.6%3.0 MB 0.9%
nnrpd 4941 0.2%525.6 KB 0.2%
overchan 11 0.0%1.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62913563 100.0%332.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2823397 93.8%
Positive hits 113637 3.8%
Negative hits 72363 2.4%
Cache misses 884 0.0%
TOTAL: 4 3010281 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:12.317 0.0%304 0.000 40.516 230.286
article cleanup00:00:36.497 0.0%2850115 0.009 0.013 0.018
article logging00:01:48.955 0.1%2850637 0.027 0.038 0.055
article parse00:43:51.343 3.0%85152044 0.016 0.031 0.046
article write00:16:23.054 1.1%2832825 0.165 0.347 0.699
artlog/artcncl00:00:00.007 0.0%301 0.000 0.023 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:51.626 0.1%99450430 0.001 0.001 0.004
hisgrep/artcncl00:00:03.088 0.0%302 0.000 10.225 38.000
hishave/artcncl00:00:00.147 0.0%304 0.000 0.484 4.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:24:20.960 5.9%3022907 0.463 1.674 5.295
history sync00:00:00.016 0.0%290 0.000 0.055 0.500
history write02:55:14.393 12.2%2835555 1.376 3.708 8.567
hiswrite/artcncl00:00:00.016 0.0%2 0.000 8.000 16.000
idle12:41:21.844 52.9%62205998 0.324 0.734 1.557
nntp read01:01:37.639 4.3%82978138 0.030 0.045 0.069
overview write00:00:13.209 0.0%2832825 0.003 0.005 0.007
perl filter04:21:27.919 18.2%2835549 3.374 5.533 9.080
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:01.646 0.3%5854260 0.038 0.052 0.075
TOTAL: 24:00:02.87123:34:04.676 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.047 0.0%374558 0.000 0.003 0.007
article prepare00:00:00.046 0.0%222276 0.000 0.000 0.002
article read00:00:38.719 0.0%54545 0.000 0.710 27.154
backlog stats00:00:01.200 0.0%1315554 0.000 0.001 0.003
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:12.993 0.0%714930 0.011 0.018 0.028
data write00:02:31.046 0.2%654042 0.052 0.231 0.420
idle23:46:42.049 99.7%1315554 36.632 65.069 842.385
status file00:00:18.530 0.0%17143 0.750 1.081 2.849
TOTAL: 23:51:06.19723:50:25.630100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:14:24.284 98.2%3120 0.000 277.014 49869.375
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.554 0.1%6945 0.000 0.080 3.211
readart00:00:00.009 0.0%62 0.000 0.145 1.000
TOTAL: 00:14:39.71200:14:24.847 98.3%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 197 28166892810636 1495 4558 99%182:17:28
2news.nask.pl 6 129259 18190 98369 12700 14%25:30:09
3news.icm.edu.pl 37 221 106 95 20 47%14:13:40
4localhost 7 6 6 0 0 100%00:00:00
TOTAL: 4 247 29461752828938 99959 17278 96%222:01:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl675.6 GB725.2 MB830.2 MB677.1 GB 99%252.2 KB
2news.nask.pl4.9 GB3.0 GB3.1 GB11.0 GB 44%374.3 KB
3news.icm.edu.pl2.0 MB11.1 KB634.7 KB2.6 MB 76%21.4 KB
4localhost8.8 KB0.0 KB0.0 KB8.8 KB100%1.5 KB
TOTAL: 4680.5 GB3.7 GB3.9 GB688.2 GB 98%253.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 23 04:15:02 - 04:59:59 83165 2.9% 30.8222.2 GB 3.3%8624.54
Oct 23 05:00:00 - 05:59:59 111753 4.0% 31.0428.9 GB 4.2%8414.95
Oct 23 06:00:00 - 06:59:59 90744 3.2% 25.2124.5 GB 3.6%7145.61
Oct 23 07:00:00 - 07:59:59 83158 2.9% 23.1023.0 GB 3.4%6684.93
Oct 23 08:00:00 - 08:59:59 71682 2.5% 19.9119.7 GB 2.9%5751.40
Oct 23 09:00:00 - 09:59:59 124032 4.4% 34.4529.1 GB 4.3%8475.54
Oct 23 10:00:00 - 10:59:59 205373 7.3% 57.0535.7 GB 5.2%10408.13
Oct 23 11:00:00 - 11:59:59 198252 7.0% 55.0731.2 GB 4.6%9089.06
Oct 23 12:00:00 - 12:59:59 84832 3.0% 23.5625.9 GB 3.8%7557.49
Oct 23 13:00:00 - 13:59:59 130704 4.6% 36.3136.9 GB 5.4%10751.72
Oct 23 14:00:00 - 14:59:59 80912 2.9% 22.4825.3 GB 3.7%7363.74
Oct 23 15:00:00 - 15:59:59 124596 4.4% 34.6138.8 GB 5.7%11296.01
Oct 23 16:00:00 - 16:59:59 144675 5.1% 40.1939.5 GB 5.8%11519.58
Oct 23 17:00:00 - 17:59:59 178600 6.3% 49.6139.1 GB 5.7%11378.10
Oct 23 18:00:00 - 18:59:59 140381 5.0% 38.9933.5 GB 4.9%9759.74
Oct 23 19:00:00 - 19:59:59 133499 4.7% 37.0823.8 GB 3.5%6924.40
Oct 23 20:00:00 - 20:59:59 136435 4.8% 37.9028.1 GB 4.1%8193.62
Oct 23 21:00:00 - 21:59:59 148351 5.2% 41.2128.4 GB 4.2%8266.59
Oct 23 22:00:00 - 22:59:59 126077 4.5% 35.0228.0 GB 4.1%8144.48
Oct 23 23:00:00 - 23:59:59 86150 3.0% 23.9321.0 GB 3.1%6127.87
Oct 24 00:00:00 - 00:59:59 93193 3.3% 25.8924.0 GB 3.5%6977.75
Oct 24 01:00:00 - 01:59:59 103923 3.7% 28.8726.0 GB 3.8%7574.83
Oct 24 02:00:00 - 02:59:59 63846 2.3% 17.7321.2 GB 3.1%6163.57
Oct 24 03:00:00 - 03:59:59 66041 2.3% 18.3421.2 GB 3.1%6170.07
Oct 24 04:00:00 - 04:15:03 18719 0.7% 20.736.3 GB 0.9%7324.68
TOTAL: 24:00:01 2829093 100.0% 32.74681.3 GB 100.0%8268.24
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 12814 7 0 10591 1 0 0 0 2215
2newsfeed.pionier.net.pl 4970 271 0 3963 0 0 0 0 736
3news.icm.edu.pl 21 0 0 1 0 0 0 0 20
TOTAL: 3 17805 278 0 14555 1 0 0 0 2971

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 211
it.comp.os.win.windows10 29
comp.mobile.android 14
it.tlc.cellulari.android 13
it.comp.os.win.windows7 4
uk.rec.cycling.moderated 2
comp.mobile.ipad 2
it.discussioni.energia 1
de.comp.os.os2 1
it.comp.os.linux.ubuntu 1
TOTAL: 10 278

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1663
Binary in non-binary group 662
EMP (phl) 31
Scoring filter (16) 28
Scoring filter (8) 24
HTML post 6
Too many newsgroups 6
Scoring filter (12) 5
EMP (fsl) 4
Scoring filter (17) 3
Scoring filter (10) 3
Scoring filter (9) 3
Scoring filter (18) 2
Scoring filter (11) 2
Scoring filter (13) 1
TOTAL: 15 2443

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 6
TOTAL: 1 6
Including strange strings
newsfeed.pionier.net.pl 412
news.nask.pl 109
news.icm.edu.pl 1
TOTAL: 3 522
TOTAL: 2 528

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 237015 52204 111330 873 0 911 22%23:59:57
2panorama 202194 893 173048 239 13 202670 0%23:59:57
3icm 209294 127 187720 1247 0 2 0%23:59:57
4poznan 4958 76 3455 14 0 0 1%23:42:39
5okapi 0 0 0 0 0 1084 0%23:57:50
TOTAL: 5 653461 53300 475553 2373 13 204667 8%119:40:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask17.5 GB285.4 MB17.8 GB215.8 KB/s351.3 KB23:59:57
2icm6.0 MB424.6 MB430.6 MB5.1 KB/s320.9 KB23:59:57
3panorama2.9 MB1.1 MB4.1 MB0.0 KB/s3.7 KB23:59:57
4poznan350.1 KB56.9 KB407.0 KB0.0 KB/s4.5 KB23:42:39
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 517.5 GB711.1 MB18.2 GB44.3 KB/s342.9 KB119:40:20
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 6259.0 KB 28 0 000:00:26
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:01
TOTAL: 2 294 6259.0 KB 28 6 000:14:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 582 6259.0 KB 28 6 000:00:31
2*.neoplus.adsl.tpnet.pl 5 00.0 KB 0 0 000:14:06
3unresolved 96 00.0 KB 0 0 000:00:01
TOTAL: 3 683 6259.0 KB 28 6 000:14:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
adat204.neoplus.adsl.tpnet.pl 0.052 0.104 0.00000:14:06
web.man.lodz.pl 1.652 7.528 0.00000:00:26
mon.man.lodz.pl 1.384 6.700 0.00000:00:03
isvcs01.man.lodz.pl 0.036 0.192 0.00000:00:01
212.51.192.185 0.396 1.964 0.00000:00:01
TOTAL: 5 3.520 16.488 0.00000:14:38

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
adat204.neoplus.adsl.tpnet.pl 5
TOTAL: 3 389

Newsgroup request counts (by category):

CategoryCountPct
1pl 62100.0%
TOTAL: 1 62100.0%

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

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