Daily Usenet report

Dec 9 04:15:02 -- Dec 10 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Dec 9 11:25:36 newsfeed nnrpd[26070]: SERVER perl filter not defined
Dec 9 12:16:45 newsfeed nnrpd[27964]: SERVER perl filter not defined
Dec 9 12:20:57 newsfeed nnrpd[28070]: SERVER perl filter not defined
Dec 9 13:03:54 newsfeed nnrpd[29477]: SERVER perl filter not defined
Dec 9 14:53:07 newsfeed nnrpd[874]: SERVER perl filter not defined
Dec 9 14:54:51 newsfeed nnrpd[921]: SERVER perl filter not defined
Dec 9 15:00:25 newsfeed nnrpd[1236]: SERVER perl filter not defined
Dec 9 15:02:42 newsfeed nnrpd[1244]: SERVER perl filter not defined
Dec 9 17:00:37 newsfeed nnrpd[5373]: SERVER perl filter not defined
Dec 9 17:00:38 newsfeed nnrpd[5447]: SERVER perl filter not defined
Dec 9 17:01:33 newsfeed nnrpd[5450]: SERVER perl filter not defined
Dec 9 20:52:31 newsfeed nnrpd[13495]: SERVER perl filter not defined
Dec 10 04:15:02 newsfeed nnrpd[29015]: web.man.lodz.pl rejected Flushing log and syslog files
Dec 10 04:15:02 newsfeed nnrpd[29023]: web.man.lodz.pl rejected Flushing log and syslog files
Dec 10 04:15:02 newsfeed nnrpd[29027]: web.man.lodz.pl rejected Flushing log and syslog files
Dec 10 04:15:02 newsfeed nnrpd[29030]: web.man.lodz.pl rejected Flushing log and syslog files

Log entries by program:

Program nameLines%LinesSize%Size
inn2659165 97.2%306.9 MB 96.8%
innfeed 47755 1.7%5.7 MB 1.8%
innd 21427 0.8%3.7 MB 1.2%
nnrpd 7004 0.3%800.7 KB 0.2%
TOTAL: 42735351 100.0%317.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2653475 98.5%
Negative hits 25071 0.9%
Positive hits 16568 0.6%
Cache misses 110 0.0%
TOTAL: 4 2695224 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.762 0.0%190 0.000 25.063 1325.000
article cleanup00:00:44.671 0.1%2659198 0.005 0.017 0.030
article logging00:01:17.652 0.1%2659750 0.014 0.029 0.698
article parse01:18:13.090 5.4%266671975 0.007 0.018 0.079
article write00:27:19.584 1.9%2655326 0.241 0.617 3.703
artlog/artcncl00:00:00.006 0.0%184 0.000 0.033 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:38.309 0.3%283819626 0.000 0.001 0.006
hisgrep/artcncl00:00:00.368 0.0%160 0.000 2.300 223.000
hishave/artcncl00:00:00.106 0.0%190 0.000 0.558 16.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:35:16.144 2.4%2697690 0.139 0.784 17.614
history sync00:00:00.017 0.0%294 0.000 0.058 1.000
history write00:47:41.196 3.3%2655966 0.196 1.077 27.718
hiswrite/artcncl00:00:00.122 0.0%30 0.000 4.067 96.000
idle13:09:19.896 54.8%184618457 0.105 0.257 0.421
nntp read01:17:53.511 5.4%264551837 0.009 0.018 0.037
overview write00:00:15.723 0.0%2655326 0.000 0.006 0.014
perl filter05:14:58.215 21.9%2655966 4.559 7.115 10.836
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:11.378 0.4%5358438 0.008 0.058 0.108
TOTAL: 24:00:21.36923:01:54.750 95.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.304 0.0%119631 0.000 0.003 0.111
article prepare00:00:00.008 0.0%27086 0.000 0.000 0.250
article read00:01:22.672 0.1%6773 0.000 12.206 1128.000
backlog stats00:00:00.191 0.0%254608 0.000 0.001 0.022
callbacks00:00:00.000 0.0%17 0.000 0.000 0.000
data read00:00:01.502 0.0%139673 0.000 0.011 0.120
data write00:00:04.800 0.0%94471 0.000 0.051 0.943
idle23:58:33.922 99.9%254608 46.702 339.007 1505.450
status file00:00:12.572 0.0%16014 0.250 0.785 12.667
TOTAL: 24:00:27.46224:00:15.971100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle17:36:56.261 99.9%235078 0.000 269.767600099.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:16.652 0.0%774421 0.000 0.022 0.500
readart00:00:04.290 0.0%265 0.000 16.189 89.444
TOTAL: 17:37:49.93317:37:17.203 99.9%----

Control commands to INND:

CommandNumber
L 1
flush 24
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 189

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1117 26542392650367 393 3479 99%322:16:18
2news.nask.pl 2 17210 3804 13068 338 22%24:44:42
3news.icm.edu.pl 46 261 41 166 54 15%16:48:15
4localhost 13 12 12 0 0 100%00:00:00
TOTAL: 4 1178 26717222654224 13627 3871 99%363:49:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl791.3 GB12.9 MB32.4 MB791.3 GB 99%312.7 KB
2news.nask.pl11.9 MB902.5 KB1.0 MB13.8 MB 86%3.4 KB
3news.icm.edu.pl1.3 MB227.7 KB1.1 MB2.6 MB 49%28.3 KB
4localhost16.3 KB0.0 KB0.0 KB16.3 KB100%1.4 KB
TOTAL: 4791.3 GB14.1 MB34.5 MB791.3 GB 99%312.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 9 04:15:02 - 04:59:59 75341 2.8% 27.9218.8 GB 2.4%7311.35
Dec 9 05:00:00 - 05:59:59 124930 4.7% 34.7033.4 GB 4.2%9719.57
Dec 9 06:00:00 - 06:59:59 126628 4.8% 35.1734.4 GB 4.4%10034.09
Dec 9 07:00:00 - 07:59:59 128305 4.8% 35.6436.4 GB 4.6%10604.64
Dec 9 08:00:00 - 08:59:59 132588 5.0% 36.8337.0 GB 4.7%10773.99
Dec 9 09:00:00 - 09:59:59 101589 3.8% 28.2230.3 GB 3.8%8821.55
Dec 9 10:00:00 - 10:59:59 103686 3.9% 28.8030.7 GB 3.9%8932.57
Dec 9 11:00:00 - 11:59:59 113977 4.3% 31.6633.5 GB 4.2%9745.05
Dec 9 12:00:00 - 12:59:59 116197 4.4% 32.2833.8 GB 4.3%9855.80
Dec 9 13:00:00 - 13:59:59 119019 4.5% 33.0634.1 GB 4.3%9935.12
Dec 9 14:00:00 - 14:59:59 116665 4.4% 32.4134.5 GB 4.4%10054.20
Dec 9 15:00:00 - 15:59:59 113418 4.3% 31.5034.1 GB 4.3%9934.08
Dec 9 16:00:00 - 16:59:59 107421 4.0% 29.8432.0 GB 4.1%9326.82
Dec 9 17:00:00 - 17:59:59 112375 4.2% 31.2233.2 GB 4.2%9672.69
Dec 9 18:00:00 - 18:59:59 104177 3.9% 28.9431.2 GB 4.0%9097.23
Dec 9 19:00:00 - 19:59:59 107515 4.1% 29.8733.3 GB 4.2%9686.49
Dec 9 20:00:00 - 20:59:59 112092 4.2% 31.1434.5 GB 4.4%10043.46
Dec 9 21:00:00 - 21:59:59 116218 4.4% 32.2834.7 GB 4.4%10100.35
Dec 9 22:00:00 - 22:59:59 117945 4.4% 32.7634.8 GB 4.4%10149.29
Dec 9 23:00:00 - 23:59:59 114985 4.3% 31.9434.4 GB 4.4%10033.75
Dec 10 00:00:00 - 00:59:59 87033 3.3% 24.1828.3 GB 3.6%8230.88
Dec 10 01:00:00 - 01:59:59 111804 4.2% 31.0635.0 GB 4.4%10182.55
Dec 10 02:00:00 - 02:59:59 81497 3.1% 22.6428.0 GB 3.5%8165.77
Dec 10 03:00:00 - 03:59:59 85052 3.2% 23.6331.3 GB 4.0%9115.69
Dec 10 04:00:00 - 04:15:02 24101 0.9% 26.728.4 GB 1.1%9805.40
TOTAL: 24:00:00 2654558 100.0% 30.72790.2 GB 100.0%9589.66
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3985 295 0 2902 6 0 0 0 782
2news.nask.pl 383 3 0 323 1 0 0 0 56
3news.icm.edu.pl 55 0 0 6 0 0 0 0 49
TOTAL: 3 4423 298 0 3231 7 0 0 0 887

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 170
it.comp.os.win.windows10 43
uk.rec.cycling.moderated 19
it.tlc.cellulari.android 19
de.rec.sf.startrek 8
hr.ponuda.hardver.komponente 7
it.comp.os.linux.ubuntu 6
de.comp.office-pakete.ms-office.outlook 5
comp.mobile.android 5
it.comp.os.win.windows7 5
comp.sys.raspberry-pi 3
de.comp.os.os2 2
hr.alt.cellular.gsm.iphone 2
it.comp.os.win.windows8 2
it.comp.virtualizzazione 1
hr.ponuda.hardver.ostalo 1
TOTAL: 16 298

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

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

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 272
EMP (md5) 51
HTML post 5
Too many newsgroups 3
EMP (fsl) 3
Scoring filter (8) 1
TOTAL: 6 335

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 79148 1752 50097 736 43 66964 2%24:00:18
2icm 43618 628 25162 2599 0 5 1%24:03:28
3poznan 5462 81 3582 26 0 0 1%23:59:33
4nask 0 0 0 0 0 13522 0%24:00:00
5okapi 0 0 0 0 0 2742 0%24:00:00
TOTAL: 5 128228 2461 78841 3361 43 83233 1%120:03:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm13.4 MB634.7 MB648.2 MB7.7 KB/s205.7 KB24:03:28
2panorama7.4 MB4.4 MB11.8 MB0.1 KB/s4.9 KB24:00:18
3poznan307.3 KB63.3 KB370.6 KB0.0 KB/s3.5 KB23:59:33
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 521.1 MB639.2 MB660.3 MB1.6 KB/s116.1 KB120:03:19
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1radius2.p.lodz.pl 5 76219.6 KB 5 1 000:21:20
2pc-212-51-218-225.p.lodz.pl 11 66145.0 KB 5 0 002:49:07
3web.man.lodz.pl 291 6467.0 KB 26 0 000:00:32
4lze200.lze.lodz.pl 11 3159.0 KB 7 0 002:09:02
5bum205.neoplus.adsl.tpnet.pl 8 1117.4 KB 3 0 201:06:24
678.9.185.59 12 510.3 KB 3 0 700:40:48
7auriga.rz.izeto.pl 3 46.3 KB 2 0 000:00:53
889-64-0-56.dynamic.chello.pl 2 32.3 KB 1 0 100:10:31
9212.191.87.58 3 21.5 KB 2 1 000:14:50
1084-10-64-208.static.chello.pl 14 21.9 KB 2 0 601:23:39
1178.9.185.49 1 11.0 KB 1 0 000:00:12
12abfc12.neoplus.adsl.tpnet.pl 4 00.0 KB 0 0 100:04:38
13isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 13 375 265531.3 KB 57 12 1717:37:49

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.p.lodz.pl 16 142364.6 KB 10 1 003:10:28
2*.man.lodz.pl 973 6467.0 KB 26 10 000:00:40
3*.lze.lodz.pl 11 3159.0 KB 7 0 002:09:02
4*.neoplus.adsl.tpnet.pl 19 1117.4 KB 3 0 301:14:24
5unresolved 18 812.9 KB 6 1 708:53:47
6*.rz.izeto.pl 3 46.3 KB 2 0 000:00:53
7*.dynamic.chello.pl 2 32.3 KB 1 0 100:10:31
8*.static.chello.pl 14 21.9 KB 2 0 601:23:39
9*.adsl.inetia.pl 2 00.0 KB 0 0 000:34:12
10*.toya.net.pl 108 00.0 KB 0 0 000:00:09
TOTAL: 101166 265531.3 KB 57 12 1717:37:49

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.195.155 12.446 15.790 0.00007:57:56
pc-212-51-218-225.p.lodz.pl 0.046 0.114 0.00002:49:07
lze200.lze.lodz.pl 0.036 0.121 0.00002:09:02
84-10-64-208.static.chello.pl 0.180 0.205 0.00001:23:39
bum205.neoplus.adsl.tpnet.pl 0.072 0.078 0.00001:06:24
78.9.185.59 0.084 0.096 0.00000:40:48
159-205-132-17.adsl.inetia.pl 0.005 0.023 0.00000:34:12
radius2.p.lodz.pl 0.864 0.388 0.00000:21:20
212.191.87.58 0.491 0.331 0.00000:14:50
89-64-0-56.dynamic.chello.pl 0.010 0.022 0.00000:10:31
abfc12.neoplus.adsl.tpnet.pl 0.130 0.044 0.00000:04:38
awh76.neoplus.adsl.tpnet.pl 0.021 0.078 0.00000:03:21
auriga.rz.izeto.pl 0.010 0.027 0.00000:00:53
web.man.lodz.pl 1.044 3.030 0.00000:00:32
78.9.185.49 0.007 0.007 0.00000:00:12
staticline41435.toya.net.pl 0.386 1.242 0.00000:00:09
mon.man.lodz.pl 1.871 6.005 0.00000:00:05
david.man.lodz.pl 0.302 0.969 0.00000:00:00
isvcs01.man.lodz.pl 0.077 0.109 0.00000:00:00
? 0.000 0.015 0.00000:00:00
TOTAL: 20 18.082 28.694 0.00017:37:49

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 576
staticline41435.toya.net.pl 108
david.man.lodz.pl 96
awh76.neoplus.adsl.tpnet.pl 7
159-205-132-17.adsl.inetia.pl 2
185.48.195.155 2
TOTAL: 6 791

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
lze200.lze.lodz.pl 4 0
pc-212-51-218-225.p.lodz.pl 3 0
84-10-64-208.static.chello.pl 2 0
bum205.neoplus.adsl.tpnet.pl 1 0
159-205-132-17.adsl.inetia.pl 1 0
TOTAL: 5 11 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 239 90.2%
2lodman 20 7.5%
3lodz 4 1.5%
4lodzman 2 0.8%
TOTAL: 4 265100.0%

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

NewsgroupCount
1pl.test 78
2pl.comp.pecet 64
3pl.misc.elektronika 44
4pl.misc.kolej 22
5lodman.test 16
6pl.comp.os.linux 12
7pl.rec.dom 11
8lodman.info 4
9lodz.test 4
10pl.rec.kuchnia 4
11pl.misc.telefonia.gsm 4
12lodzman.test 2
TOTAL: 12 265