Daily Usenet report

Nov 19 04:15:03 -- Nov 20 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Nov 19 08:36:19 newsfeed nnrpd[16086]: SERVER perl filter not defined
Nov 19 11:14:18 newsfeed nnrpd[21384]: SERVER perl filter not defined
Nov 19 13:51:26 newsfeed nnrpd[26494]: SERVER perl filter not defined
Nov 19 15:15:01 newsfeed overchan[6703]: input line too long, skipping
Nov 19 18:12:13 newsfeed overchan[6703]: input line too long, skipping
Nov 19 19:37:37 newsfeed overchan[6703]: input line too long, skipping
Nov 19 20:56:05 newsfeed overchan[1512]: input line too long, skipping
Nov 19 22:55:52 newsfeed nnrpd[15279]: SERVER perl filter not defined
Nov 19 23:27:28 newsfeed overchan[1512]: input line too long, skipping
Nov 19 23:27:43 newsfeed overchan[1512]: input line too long, skipping
Nov 19 23:29:05 newsfeed overchan[1512]: input line too long, skipping
Nov 20 00:29:05 newsfeed overchan[1512]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2245239 97.2%265.3 MB 96.9%
innfeed 45250 2.0%5.4 MB 2.0%
innd 15075 0.7%2.5 MB 0.9%
nnrpd 4958 0.2%530.2 KB 0.2%
overchan 9 0.0%1.4 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 62310533 100.0%273.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2226791 91.2%
Positive hits 129514 5.3%
Negative hits 83100 3.4%
Cache misses 1124 0.0%
TOTAL: 4 2440529 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.272 0.0%133 0.000 47.158 279.500
article cleanup00:00:27.075 0.0%2250948 0.008 0.012 0.016
article logging00:01:48.705 0.1%2251586 0.031 0.048 0.073
article parse00:40:00.693 2.8%85695928 0.015 0.028 0.046
article write00:17:21.033 1.2%2240894 0.246 0.465 0.783
artlog/artcncl00:00:00.002 0.0%131 0.000 0.015 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:00.341 0.2%98987835 0.001 0.002 0.003
hisgrep/artcncl00:00:02.265 0.0%132 0.000 17.159 137.500
hishave/artcncl00:00:00.327 0.0%133 0.000 2.459 15.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:48:44.605 11.7%2458399 1.116 4.118 8.201
history sync00:00:00.012 0.0%289 0.000 0.042 0.500
history write05:37:35.135 23.4%2242853 3.439 9.031 18.222
hiswrite/artcncl00:00:00.009 0.0%1 9.000 9.000 9.000
idle09:16:57.675 38.7%59858931 0.139 0.558 1.369
nntp read00:57:15.457 4.0%84100295 0.025 0.041 0.055
overview write00:00:11.466 0.0%2240894 0.003 0.005 0.008
perl filter03:50:50.420 16.0%2242853 3.455 6.175 8.018
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:59.480 0.3%4812875 0.041 0.062 0.077
TOTAL: 24:00:04.47923:39:20.972 98.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.964 0.0%620804 0.001 0.003 0.006
article prepare00:00:00.191 0.0%864758 0.000 0.000 0.001
article read00:02:50.439 0.2%188680 0.200 0.903 204.500
backlog stats00:00:02.196 0.0%2548890 0.000 0.001 0.002
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:25.915 0.0%1325563 0.010 0.020 0.027
data write00:05:17.668 0.4%1329618 0.028 0.239 0.390
idle23:40:24.305 99.3%2548890 20.585 33.436 321.202
status file00:00:23.916 0.0%16710 0.800 1.431 8.580
TOTAL: 23:50:37.99823:49:26.594 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:40.081 71.0%3173 0.000 12.632 6016.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.264 0.5%7172 0.000 0.037 0.667
readart00:00:00.017 0.0%146 0.000 0.116 5.000
TOTAL: 00:00:56.45000:00:40.362 71.5%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 150
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 195

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 368 22257982219511 2248 4039 99%447:23:57
2news.nask.pl 3 137757 12953 118850 5954 9%23:46:27
3news.icm.edu.pl 44 234 114 99 21 48%16:07:18
4localhost 5 4 4 0 0 100%00:00:01
TOTAL: 4 420 23637932232582 121197 10014 94%487:17:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl684.7 GB211.3 MB216.8 MB685.1 GB 99%323.1 KB
2news.nask.pl2.8 GB995.6 MB1008.7 MB4.8 GB 58%264.5 KB
3news.icm.edu.pl2.0 MB66.7 KB762.7 KB2.8 MB 70%21.0 KB
4localhost13.3 KB0.0 KB0.0 KB13.3 KB100%3.3 KB
TOTAL: 4687.5 GB1.2 GB1.2 GB689.9 GB 99%322.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 19 04:15:03 - 04:59:59 67854 3.0% 25.1623.5 GB 3.4%9133.97
Nov 19 05:00:00 - 05:59:59 103433 4.6% 28.7333.4 GB 4.8%9714.53
Nov 19 06:00:00 - 06:59:59 104109 4.7% 28.9234.1 GB 5.0%9946.55
Nov 19 07:00:00 - 07:59:59 123210 5.5% 34.2336.8 GB 5.3%10710.62
Nov 19 08:00:00 - 08:59:59 115324 5.2% 32.0341.4 GB 6.0%12068.64
Nov 19 09:00:00 - 09:59:59 106290 4.8% 29.5233.4 GB 4.8%9720.77
Nov 19 10:00:00 - 10:59:59 129530 5.8% 35.9840.2 GB 5.8%11705.88
Nov 19 11:00:00 - 11:59:59 65929 3.0% 18.3120.8 GB 3.0%6059.96
Nov 19 12:00:00 - 12:59:59 66955 3.0% 18.6021.1 GB 3.1%6148.81
Nov 19 13:00:00 - 13:59:59 81470 3.6% 22.6327.5 GB 4.0%8004.63
Nov 19 14:00:00 - 14:59:59 85122 3.8% 23.6427.5 GB 4.0%8010.65
Nov 19 15:00:00 - 15:59:59 88312 4.0% 24.5327.7 GB 4.0%8059.70
Nov 19 16:00:00 - 16:59:59 81952 3.7% 22.7627.2 GB 3.9%7914.17
Nov 19 17:00:00 - 17:59:59 80465 3.6% 22.3525.7 GB 3.7%7495.57
Nov 19 18:00:00 - 18:59:59 77792 3.5% 21.6127.3 GB 4.0%7945.18
Nov 19 19:00:00 - 19:59:59 117493 5.3% 32.6438.4 GB 5.6%11174.25
Nov 19 20:00:00 - 20:59:59 100461 4.5% 27.9129.9 GB 4.3%8706.76
Nov 19 21:00:00 - 21:59:59 112851 5.1% 31.3526.6 GB 3.9%7738.86
Nov 19 22:00:00 - 22:59:59 89325 4.0% 24.8122.4 GB 3.3%6521.51
Nov 19 23:00:00 - 23:59:59 68663 3.1% 19.0719.3 GB 2.8%5621.80
Nov 20 00:00:00 - 00:59:59 89100 4.0% 24.7523.1 GB 3.3%6716.06
Nov 20 01:00:00 - 01:59:59 74923 3.4% 20.8124.2 GB 3.5%7053.37
Nov 20 02:00:00 - 02:59:59 70310 3.1% 19.5319.9 GB 2.9%5809.94
Nov 20 03:00:00 - 03:59:59 113549 5.1% 31.5430.6 GB 4.4%8914.04
Nov 20 04:00:00 - 04:15:02 19994 0.9% 22.176.5 GB 0.9%7582.78
TOTAL: 23:59:59 2234416 100.0% 25.86688.4 GB 100.0%8354.47
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 6147 14 0 4440 1 0 0 0 1692
2newsfeed.pionier.net.pl 4521 319 0 3652 3 0 0 0 547
3news.icm.edu.pl 24 0 0 4 0 0 0 0 20
TOTAL: 3 10692 333 0 8096 4 0 0 0 2259

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 201
it.comp.os.win.windows10 46
it.tlc.cellulari.android 46
comp.mobile.android 29
de.comp.lang.php 2
de.comp.lang.vbclassic 2
it.comp.os.linux.ubuntu 2
comp.sys.raspberry-pi 1
comp.mobile.ipad 1
it.comp.os.win.windows7 1
hr.ponuda.hardver.komponente 1
de.comp.office-pakete.ms-office.outlook 1
TOTAL: 12 333

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

GroupsCount
pl.praca.oferowana 3
bit.listserv.catholic 1
TOTAL: 2 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1326
Binary in non-binary group 164
Scoring filter (16) 63
Scoring filter (9) 16
Scoring filter (8) 15
Too many newsgroups 11
Scoring filter (13) 6
Scoring filter (11) 4
EMP (phl) 3
Scoring filter (10) 3
Scoring filter (18) 3
Excessively crossposted test article 2
Scoring filter (12) 2
EMP (fsl) 1
HTML post 1
Angle-bracket bot 1
TOTAL: 16 1621

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 473
news.nask.pl 162
news.icm.edu.pl 3
TOTAL: 3 638
TOTAL: 1 638

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 398104 181135 127822 305 0 2002 45%23:53:32
2panorama 314426 5059 281213 379 7 335578 1%23:59:00
3poznan 7660 65 5474 32 0 0 0%23:48:33
4icm 364132 52 300618 28995 0 4 0%23:53:32
5okapi 0 0 0 0 0 1105 0%23:51:26
TOTAL: 51084322 186311 715127 29711 7 338689 17%119:26:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask67.0 GB93.2 MB67.1 GB817.4 KB/s387.5 KB23:53:32
2panorama1.4 GB16.2 MB1.4 GB17.3 KB/s274.3 KB23:59:00
3icm4.2 MB10.7 GB10.7 GB130.3 KB/s385.7 KB23:53:32
4poznan209.8 KB84.1 KB294.0 KB0.0 KB/s3.0 KB23:48:33
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:51:26
TOTAL: 568.4 GB10.8 GB79.2 GB193.1 KB/s384.2 KB119:26:03
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama3.3 MB
TOTAL: 13.3 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 146165.7 KB 62 0 000:00:23
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:01
TOTAL: 2 292 146165.7 KB 62 4 000:00:55

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 580 146165.7 KB 62 4 000:00:29
2*.security.ipip.net 1 00.0 KB 0 0 000:00:00
3*.oxylion.net.pl 1 00.0 KB 0 0 000:00:24
4unresolved 96 00.0 KB 0 0 000:00:01
TOTAL: 4 678 146165.7 KB 62 4 000:00:55

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
host-81-161-194-212.oxylion.net.pl 0.000 0.008 0.00000:00:24
web.man.lodz.pl 1.400 4.224 0.00000:00:23
mon.man.lodz.pl 1.320 3.880 0.00000:00:04
212.51.192.185 0.412 1.188 0.00000:00:01
isvcs01.man.lodz.pl 0.044 0.108 0.00000:00:01
scan-141.security.ipip.net 0.000 0.016 0.00000:00:00
TOTAL: 6 3.176 9.424 0.00000:00:55

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
scan-141.security.ipip.net 1
host-81-161-194-212.oxylion.net.pl 1
TOTAL: 4 386

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

Newsgroup request counts (by category):

CategoryCountPct
1pl 146100.0%
TOTAL: 1 146100.0%

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

NewsgroupCount
1pl.comp.pecet 110
2pl.comp.os.ms-windows.winnt 36
TOTAL: 2 146