Daily Usenet report

Oct 1 04:15:32 -- Oct 2 04:15:03

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Oct 1 08:55:42 newsfeed nnrpd[25670]: SERVER perl filter not defined
Oct 1 08:57:28 newsfeed nnrpd[25687]: SERVER perl filter not defined
Oct 1 08:59:26 newsfeed nnrpd[25727]: SERVER perl filter not defined
Oct 1 09:02:14 newsfeed nnrpd[25823]: SERVER perl filter not defined
Oct 1 11:09:38 newsfeed overchan[15021]: input line too long, skipping
Oct 1 11:15:09 newsfeed nnrpd[31011]: SERVER perl filter not defined
Oct 1 14:32:04 newsfeed nnrpd[5930]: SERVER perl filter not defined
Oct 1 14:50:01 newsfeed nnrpd[6647]: SERVER perl filter not defined
Oct 1 15:59:34 newsfeed overchan[15021]: input line too long, skipping
Oct 1 16:02:05 newsfeed nnrpd[9370]: SERVER perl filter not defined
Oct 1 16:02:13 newsfeed overchan[15021]: input line too long, skipping
Oct 1 16:32:04 newsfeed overchan[15021]: input line too long, skipping
Oct 1 17:13:11 newsfeed overchan[15021]: input line too long, skipping
Oct 1 17:15:16 newsfeed overchan[15021]: input line too long, skipping
Oct 1 19:26:32 newsfeed nnrpd[17352]: SERVER perl filter not defined
Oct 1 19:33:17 newsfeed overchan[15021]: input line too long, skipping
Oct 1 20:19:05 newsfeed overchan[15021]: input line too long, skipping
Oct 1 20:25:20 newsfeed overchan[15021]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2019179 96.5%238.1 MB 96.3%
innfeed 44413 2.1%5.3 MB 2.1%
innd 23462 1.1%3.4 MB 1.4%
nnrpd 4900 0.2%519.9 KB 0.2%
overchan 10 0.0%1.5 KB 0.0%
TOTAL: 52091964 100.0%247.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1977080 83.0%
Positive hits 252056 10.6%
Negative hits 147626 6.2%
Cache misses 4235 0.2%
TOTAL: 4 2380997 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:43.440 0.1%760 0.000 57.158 888.444
article cleanup00:00:30.762 0.0%2014560 0.008 0.015 0.031
article logging00:02:01.490 0.1%2015100 0.048 0.060 1.290
article parse00:54:24.510 3.8%67171948 0.033 0.049 0.094
article write00:21:43.697 1.5%1960892 0.424 0.665 8.756
artlog/artcncl00:00:00.036 0.0%654 0.000 0.055 1.000
artlog/artparse00:00:00.014 0.0%444 0.000 0.032 0.111
data move00:03:13.986 0.2%79232739 0.001 0.002 0.022
hisgrep/artcncl00:00:08.868 0.0%513 0.000 17.287 440.000
hishave/artcncl00:00:07.647 0.0%760 0.000 10.062 138.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup05:03:05.486 21.0%2400474 0.979 7.576 389.433
history sync00:00:00.022 0.0%290 0.000 0.076 1.500
history write06:24:55.710 26.7%1963294 3.287 11.764 603.204
hiswrite/artcncl00:00:04.626 0.0%247 1.000 18.729 42.000
idle04:43:19.969 19.7%34284304 0.083 0.496 1.322
nntp read01:03:22.469 4.4%65607016 0.049 0.058 0.084
overview write00:00:12.511 0.0%1960892 0.005 0.006 0.014
perl filter04:52:21.283 20.3%1963270 7.015 8.935 11.021
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:24.809 0.4%4277241 0.060 0.076 0.101
TOTAL: 24:00:24.47723:35:41.335 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:02.346 0.0%635065 0.000 0.004 0.009
article prepare00:00:00.074 0.0%212230 0.000 0.000 0.004
article read00:16:44.355 1.2%48529 0.367 20.696 3949.339
backlog stats00:00:02.139 0.0%1970060 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:32.520 0.0%1186904 0.014 0.027 0.038
data write00:03:34.209 0.2%944542 0.065 0.227 0.455
idle23:23:16.086 98.1%1970060 21.826 42.738 297.071
status file00:05:27.356 0.4%16807 0.975 19.477 325.162
TOTAL: 23:50:59.40623:49:39.085 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.280 53.7%3074 0.000 6.272 123.889
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.376 1.0%6737 0.000 0.056 3.789
readart00:00:00.000 0.0%30 0.000 0.000 0.000
TOTAL: 00:00:35.91300:00:19.656 54.7%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 365 19248551917826 1123 5906 99%523:01:08
2news.nask.pl 739 296406 45673 202635 48098 15%121:55:47
3news.icm.edu.pl 41 229 118 83 28 51%17:01:21
4localhost 10 9 9 0 0 100%00:00:02
TOTAL: 4 1155 22214991963626 203841 54032 88%661:58:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl674.7 GB1.8 GB1.9 GB678.4 GB 99%369.8 KB
2news.nask.pl22.0 GB22.7 GB22.9 GB67.6 GB 32%756.1 KB
3news.icm.edu.pl2.5 MB250.9 KB547.7 KB3.3 MB 76%23.3 KB
4localhost13.4 KB0.0 KB0.0 KB13.4 KB100%1.5 KB
TOTAL: 4696.7 GB24.5 GB24.8 GB746.1 GB 93%387.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 1 04:15:32 - 04:59:59 13364 0.7% 5.014.7 GB 0.7%1854.13
Oct 1 05:00:00 - 05:59:59 31964 1.6% 8.8811.6 GB 1.7%3388.17
Oct 1 06:00:00 - 06:59:59 50126 2.6% 13.9217.6 GB 2.5%5124.61
Oct 1 07:00:00 - 07:59:59 73593 3.7% 20.4426.9 GB 3.9%7846.34
Oct 1 08:00:00 - 08:59:59 80969 4.1% 22.4930.2 GB 4.3%8782.38
Oct 1 09:00:00 - 09:59:59 81826 4.2% 22.7329.7 GB 4.3%8662.20
Oct 1 10:00:00 - 10:59:59 85410 4.3% 23.7329.9 GB 4.3%8718.02
Oct 1 11:00:00 - 11:59:59 79114 4.0% 21.9828.7 GB 4.1%8359.67
Oct 1 12:00:00 - 12:59:59 88313 4.5% 24.5331.9 GB 4.6%9289.06
Oct 1 13:00:00 - 13:59:59 88003 4.5% 24.4532.9 GB 4.7%9591.93
Oct 1 14:00:00 - 14:59:59 83142 4.2% 23.0930.8 GB 4.4%8972.25
Oct 1 15:00:00 - 15:59:59 99509 5.1% 27.6430.8 GB 4.4%8975.93
Oct 1 16:00:00 - 16:59:59 92873 4.7% 25.8033.7 GB 4.8%9807.75
Oct 1 17:00:00 - 17:59:59 91546 4.7% 25.4332.0 GB 4.6%9316.86
Oct 1 18:00:00 - 18:59:59 96654 4.9% 26.8534.4 GB 4.9%10033.97
Oct 1 19:00:00 - 19:59:59 95576 4.9% 26.5534.7 GB 5.0%10095.67
Oct 1 20:00:00 - 20:59:59 91432 4.7% 25.4032.2 GB 4.6%9388.92
Oct 1 21:00:00 - 21:59:59 101492 5.2% 28.1931.8 GB 4.6%9261.46
Oct 1 22:00:00 - 22:59:59 82961 4.2% 23.0428.2 GB 4.0%8212.58
Oct 1 23:00:00 - 23:59:59 78152 4.0% 21.7126.4 GB 3.8%7677.16
Oct 2 00:00:00 - 00:59:59 75568 3.8% 20.9923.3 GB 3.3%6784.74
Oct 2 01:00:00 - 01:59:59 97537 5.0% 27.0932.0 GB 4.6%9322.20
Oct 2 02:00:00 - 02:59:59 94303 4.8% 26.2037.9 GB 5.4%11045.20
Oct 2 03:00:00 - 03:59:59 88784 4.5% 24.6635.7 GB 5.1%10385.20
Oct 2 04:00:00 - 04:15:03 21660 1.1% 23.998.8 GB 1.3%10223.36
TOTAL: 23:59:31 1963871 100.0% 22.74696.9 GB 100.0%8460.37
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 48221 7 0 46114 2 0 0 0 2098
2newsfeed.pionier.net.pl 6405 140 0 5176 4 0 0 0 1085
3news.icm.edu.pl 28 0 0 15 0 0 0 0 13
TOTAL: 3 54654 147 0 51305 6 0 0 0 3196

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 59
it.tlc.cellulari.android 28
comp.mobile.android 25
it.comp.os.win.windows10 22
nl.comp.os.linux.techniek 5
de.comp.lang.vbclassic 5
comp.sys.raspberry-pi 3
TOTAL: 7 147

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

GroupsCount
pl.praca.oferowana 4
bit.listserv.catholic 1
courts.usa.federal.supreme 1
TOTAL: 3 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1577
Binary in non-binary group 592
Scoring filter (8) 23
EMP (phl) 15
Scoring filter (16) 6
Scoring filter (9) 5
HTML post 2
Scoring filter (18) 2
Scoring filter (11) 1
Attached HTML file 1
TOTAL: 10 2224

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 1
TOTAL: 1 1
Bad command received
news.nask.pl 5948
TOTAL: 1 5948
Including strange strings
newsfeed.pionier.net.pl 497
news.nask.pl 42
news.icm.edu.pl 2
TOTAL: 3 541
No colon-space in header
news.nask.pl 19
TOTAL: 1 19
TOTAL: 4 6509

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 394790 32793 267156 3113 0 2441 8%23:59:22
2panorama 304871 4029 272831 399 7 360640 1%23:59:20
3poznan 3526 47 2623 23 0 0 1%20:26:59
4icm 380853 31 342245 13275 0 5 0%23:59:22
5okapi 0 0 0 0 0 1362 0%23:42:22
TOTAL: 51084040 36900 884855 16810 7 364448 3%116:07:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask15.9 GB1.6 GB17.5 GB212.5 KB/s511.0 KB23:59:22
2panorama1.3 GB27.3 MB1.3 GB16.0 KB/s312.0 KB23:59:20
3icm3.7 MB6.0 GB6.0 GB72.9 KB/s473.1 KB23:59:22
4poznan449.7 KB96.0 KB545.6 KB0.0 KB/s7.8 KB20:26:59
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:42:22
TOTAL: 517.2 GB7.6 GB24.8 GB62.3 KB/s484.5 KB116:07:25
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama6.2 MB
TOTAL: 16.2 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3028.7 KB 14 0 000:00:26
2isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:02
TOTAL: 2 297 3028.7 KB 14 9 000:00:35

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 585 3028.7 KB 14 9 000:00:33
2unresolved 96 00.0 KB 0 0 000:00:01
TOTAL: 2 681 3028.7 KB 14 9 000:00:35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.716 6.192 0.00000:00:26
mon.man.lodz.pl 1.512 5.976 0.00000:00:04
isvcs01.man.lodz.pl 0.076 0.232 0.00000:00:02
212.51.192.185 0.552 2.000 0.00000:00:01
TOTAL: 4 3.856 14.400 0.00000:00:35

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
TOTAL: 2 384

Newsgroup request counts (by category):

CategoryCountPct
1pl 30100.0%
TOTAL: 1 30100.0%

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

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