Daily Usenet report

Jan 8 04:15:03 -- Jan 9 04:15:03

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Jan 8 12:55:03 newsfeed nnrpd[13821]: SERVER perl filter not defined
Jan 8 13:25:59 newsfeed nnrpd[14930]: SERVER perl filter not defined
Jan 8 13:30:05 newsfeed nnrpd[15022]: SERVER perl filter not defined
Jan 8 13:30:21 newsfeed nnrpd[15023]: SERVER perl filter not defined
Jan 8 14:20:40 newsfeed nnrpd[16857]: SERVER perl filter not defined
Jan 8 14:22:01 newsfeed nnrpd[16871]: SERVER perl filter not defined
Jan 8 16:45:58 newsfeed overchan[26658]: input line too long, skipping
Jan 8 16:59:34 newsfeed overchan[26658]: input line too long, skipping
Jan 8 17:27:47 newsfeed nnrpd[23658]: SERVER perl filter not defined
Jan 8 19:06:02 newsfeed overchan[26658]: input line too long, skipping
Jan 8 19:10:38 newsfeed overchan[26658]: input line too long, skipping
Jan 8 19:21:19 newsfeed nnrpd[31603]: SERVER perl filter not defined
Jan 8 20:34:24 newsfeed overchan[26658]: input line too long, skipping
Jan 8 20:47:13 newsfeed overchan[26658]: input line too long, skipping
Jan 8 20:48:42 newsfeed overchan[26658]: input line too long, skipping
Jan 8 22:41:54 newsfeed nnrpd[6541]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn3216872 97.8%358.9 MB 97.4%
innfeed 46122 1.4%5.4 MB 1.5%
innd 22549 0.7%3.7 MB 1.0%
nnrpd 4814 0.1%505.2 KB 0.1%
overchan 8 0.0%1.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 63290366 100.0%368.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3177397 96.6%
Negative hits 100051 3.0%
Positive hits 12434 0.4%
Cache misses 43 0.0%
TOTAL: 4 3289925 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.740 0.0%263 0.000 21.825 791.000
article cleanup00:00:36.437 0.0%3212910 0.009 0.011 0.017
article logging00:01:53.216 0.1%3213588 0.025 0.035 0.094
article parse00:38:10.549 2.7%111838069 0.011 0.020 0.037
article write00:15:37.743 1.1%3204782 0.150 0.293 0.544
artlog/artcncl00:00:00.003 0.0%123 0.000 0.024 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:42.196 0.1%127232104 0.001 0.001 0.002
hisgrep/artcncl00:00:00.254 0.0%241 0.000 1.054 23.000
hishave/artcncl00:00:00.113 0.0%263 0.000 0.430 28.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:02:33.776 8.5%3323375 0.218 2.213 9.636
history sync00:00:00.008 0.0%290 0.000 0.028 0.500
history write05:31:22.483 23.0%3209858 1.087 6.194 15.598
hiswrite/artcncl00:00:00.975 0.0%22 0.000 44.318 63.467
idle09:49:14.171 40.9%85909108 0.156 0.412 1.600
nntp read00:47:51.401 3.3%109273144 0.018 0.026 0.044
overview write00:00:14.473 0.0%3204782 0.003 0.005 0.006
perl filter04:20:28.818 18.1%3209858 3.758 4.869 7.340
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:40.142 0.3%6430267 0.033 0.044 0.066
TOTAL: 24:00:03.66223:34:32.498 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.134 0.0%57909 0.000 0.002 0.010
article prepare00:00:00.002 0.0%5222 0.000 0.000 0.083
article read00:00:52.788 0.1%1294 0.000 40.794 394.250
backlog stats00:00:00.125 0.0%161431 0.000 0.001 0.005
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:01.200 0.0%87351 0.003 0.014 0.029
data write00:00:03.122 0.0%67073 0.018 0.047 0.088
idle23:52:47.593 99.9%161431 347.794 532.535 857.244
status file00:00:43.167 0.1%16508 0.413 2.615 35.508
TOTAL: 23:54:37.87423:54:28.131100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:52.287 76.6%3086 0.000 16.943 10038.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.221 0.3%6696 0.000 0.033 0.667
readart00:00:00.000 0.0%14 0.000 0.000 0.000
TOTAL: 00:01:08.25600:00:52.508 76.9%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 164 32088363196916 8111 3809 99%192:22:02
2news.nask.pl 2 16110 10949 848 4313 67%24:00:38
3news.icm.edu.pl 37 393 25 324 44 6%17:52:43
4localhost 10 9 9 0 0 100%00:00:01
TOTAL: 4 213 32253483207899 9283 8166 99%234:15:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl636.3 GB91.6 MB225.2 MB636.6 GB 99%208.6 KB
2news.nask.pl44.3 MB965.3 KB139.3 MB184.6 MB 24%12.4 KB
3news.icm.edu.pl1.6 MB24.2 KB2.2 MB3.9 MB 42%57.7 KB
4localhost22.8 KB0.0 KB0.0 KB22.8 KB100%2.5 KB
TOTAL: 4636.4 GB92.6 MB366.7 MB636.8 GB 99%207.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 8 04:15:03 - 04:59:59 80200 2.5% 29.7419.1 GB 3.0%7422.88
Jan 8 05:00:00 - 05:59:59 89317 2.8% 24.8123.1 GB 3.6%6740.04
Jan 8 06:00:00 - 06:59:59 79367 2.5% 22.0518.9 GB 3.0%5497.65
Jan 8 07:00:00 - 07:59:59 61714 1.9% 17.1413.2 GB 2.1%3831.77
Jan 8 08:00:00 - 08:59:59 119506 3.7% 33.2031.1 GB 4.9%9047.51
Jan 8 09:00:00 - 09:59:59 120874 3.8% 33.5827.2 GB 4.3%7932.06
Jan 8 10:00:00 - 10:59:59 133615 4.2% 37.1228.4 GB 4.5%8259.49
Jan 8 11:00:00 - 11:59:59 103701 3.2% 28.8120.4 GB 3.2%5933.93
Jan 8 12:00:00 - 12:59:59 120857 3.8% 33.5724.7 GB 3.9%7187.72
Jan 8 13:00:00 - 13:59:59 101982 3.2% 28.3322.1 GB 3.5%6443.05
Jan 8 14:00:00 - 14:59:59 129473 4.0% 35.9629.4 GB 4.6%8556.41
Jan 8 15:00:00 - 15:59:59 143855 4.5% 39.9630.5 GB 4.8%8894.35
Jan 8 16:00:00 - 16:59:59 143338 4.5% 39.8232.0 GB 5.0%9330.59
Jan 8 17:00:00 - 17:59:59 129577 4.0% 35.9933.5 GB 5.3%9768.43
Jan 8 18:00:00 - 18:59:59 132019 4.1% 36.6732.2 GB 5.1%9391.05
Jan 8 19:00:00 - 19:59:59 154277 4.8% 42.8531.6 GB 5.0%9205.02
Jan 8 20:00:00 - 20:59:59 132533 4.1% 36.8128.1 GB 4.4%8170.77
Jan 8 21:00:00 - 21:59:59 139044 4.3% 38.6228.3 GB 4.4%8256.03
Jan 8 22:00:00 - 22:59:59 142354 4.4% 39.5426.2 GB 4.1%7632.54
Jan 8 23:00:00 - 23:59:59 206971 6.5% 57.4930.2 GB 4.7%8805.02
Jan 9 00:00:00 - 00:59:59 193163 6.0% 53.6623.9 GB 3.8%6974.09
Jan 9 01:00:00 - 01:59:59 186890 5.8% 51.9121.0 GB 3.3%6117.48
Jan 9 02:00:00 - 02:59:59 202950 6.3% 56.3829.9 GB 4.7%8721.27
Jan 9 03:00:00 - 03:59:59 125771 3.9% 34.9426.8 GB 4.2%7819.93
Jan 9 04:00:00 - 04:15:03 34551 1.1% 38.265.1 GB 0.8%5916.87
TOTAL: 24:00:00 3207899 100.0% 37.13637.1 GB 100.0%7731.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4630 28 0 235 17 0 0 0 4350
2newsfeed.pionier.net.pl 4175 75 0 2838 2 0 0 0 1260
3news.icm.edu.pl 45 0 0 2 0 0 0 0 43
TOTAL: 3 8850 103 0 3075 19 0 0 0 5653

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 25
it.comp.os.win.windows10 21
comp.mobile.android 16
comp.sys.raspberry-pi 12
it.comp.os.win.windows7 12
it.tlc.cellulari.android 10
de.comp.lang.vbclassic 4
it.discussioni.energia 1
hr.rec.glazba.hifi 1
it.comp.dotnet 1
TOTAL: 10 103

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

GroupsCount
pl.sci.matematyka 14
pl.praca.oferowana 2
pl.sci.historia 2
bit.listserv.catholic 1
TOTAL: 4 19

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3172
Binary in non-binary group 1680
Scoring filter (9) 39
Scoring filter (8) 30
Scoring filter (10) 17
Scoring filter (13) 7
Scoring filter (16) 6
HTML post 6
Excessively crossposted test article 6
EMP (fsl) 5
Poison newsgroup 4
Scoring filter (11) 2
Too many newsgroups 2
Scoring filter (18) 1
Scoring filter (12) 1
Scoring filter (14) 1
TOTAL: 16 4979

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 366
news.nask.pl 307
news.icm.edu.pl 1
TOTAL: 3 674
TOTAL: 1 674

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1poznan 17341 357 10515 24 1 1 2%23:59:58
2panorama 40763 350 12810 119 4 44797 0%23:59:58
3icm 24259 97 20333 3 0 1 0%23:59:52
4nask 2313 1 1989 2 0 1 0%23:59:20
5okapi 0 0 0 0 0 1394 0%23:57:51
TOTAL: 5 84676 805 45647 148 5 46194 0%119:56:59
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm20.5 MB12.5 KB20.5 MB0.2 KB/s210.4 KB23:59:52
2panorama5.1 MB3.3 MB8.4 MB0.1 KB/s18.4 KB23:59:58
3poznan1.3 MB111.9 KB1.5 MB0.0 KB/s3.9 KB23:59:58
4nask97.9 KB2.7 KB100.6 KB0.0 KB/s33.5 KB23:59:20
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 527.1 MB3.4 MB30.5 MB0.1 KB/s32.8 KB119:56:59
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 1411.4 KB 7 0 000:00:33
2isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:04
TOTAL: 2 297 1411.4 KB 7 9 000:01:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 681 1411.4 KB 7 9 000:00:42
2*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
3unresolved 4 00.0 KB 0 0 000:00:24
TOTAL: 3 686 1411.4 KB 7 9 000:01:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.316 7.860 0.00000:00:33
212.51.203.199 0.004 0.028 0.00000:00:14
185.48.195.97 0.004 0.012 0.00000:00:10
isvcs01.man.lodz.pl 0.052 0.216 0.00000:00:04
mon.man.lodz.pl 0.884 6.876 0.00000:00:03
david.man.lodz.pl 0.296 2.268 0.00000:00:00
ec2-13-57-205-25.us-west-1.compute.amazonaws.com 0.004 0.024 0.00000:00:00
TOTAL: 7 2.560 17.284 0.00000:01:07

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
185.48.195.97 2
212.51.203.199 2
ec2-13-57-205-25.us-west-1.compute.amazonaws.com 1
TOTAL: 5 389

Newsgroup request counts (by category):

CategoryCountPct
1pl 14100.0%
TOTAL: 1 14100.0%

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

NewsgroupCount
1pl.comp.pecet 10
2pl.comp.os.ms-windows.winnt 4
TOTAL: 2 14