Daily Usenet report

Dec 5 04:15:04 -- Dec 6 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Dec 5 08:22:24 newsfeed nnrpd[17850]: SERVER perl filter not defined
Dec 5 09:17:16 newsfeed nnrpd[19831]: SERVER perl filter not defined
Dec 5 10:05:25 newsfeed nnrpd[21563]: SERVER perl filter not defined
Dec 5 10:14:58 newsfeed nnrpd[21854]: SERVER perl filter not defined
Dec 5 11:56:14 newsfeed nnrpd[25357]: SERVER perl filter not defined
Dec 5 13:16:52 newsfeed nnrpd[28150]: SERVER perl filter not defined
Dec 5 14:50:35 newsfeed nnrpd[31359]: SERVER perl filter not defined
Dec 5 16:17:45 newsfeed nnrpd[1968]: message repeated 2 times: [ 89-65-16-106.dynamic.chello.pl group lodzman.test 0]
Dec 5 16:37:32 newsfeed nnrpd[2629]: SERVER perl filter not defined
Dec 5 16:40:58 newsfeed nnrpd[2842]: SERVER perl filter not defined
Dec 5 18:39:10 newsfeed nnrpd[6952]: SERVER perl filter not defined
Dec 5 18:41:21 newsfeed nnrpd[7012]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2941670 97.5%338.8 MB 97.1%
innfeed 45144 1.5%5.4 MB 1.5%
innd 25148 0.8%4.2 MB 1.2%
nnrpd 5129 0.2%554.3 KB 0.2%
TOTAL: 43017091 100.0%349.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2934974 98.7%
Negative hits 23493 0.8%
Positive hits 16054 0.5%
Cache misses 139 0.0%
TOTAL: 4 2974660 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:05.187 0.0%296 0.000 17.524 349.000
article cleanup00:00:44.269 0.1%2941251 0.005 0.015 0.026
article logging00:01:20.831 0.1%2941752 0.013 0.027 0.265
article parse01:18:16.025 5.4%283995444 0.005 0.017 0.087
article write00:26:05.083 1.8%2935396 0.318 0.533 3.761
artlog/artcncl00:00:00.004 0.0%251 0.000 0.016 1.000
artlog/artparse00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:06:00.452 0.4%302508056 0.000 0.001 0.009
hisgrep/artcncl00:00:01.292 0.0%257 0.000 5.027 348.000
hishave/artcncl00:00:00.083 0.0%296 0.000 0.280 17.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:43:09.662 3.0%2976890 0.129 0.870 25.461
history sync00:00:00.010 0.0%293 0.000 0.034 1.000
history write01:00:16.473 4.2%2937370 0.210 1.231 42.510
hiswrite/artcncl00:00:00.073 0.0%39 0.000 1.872 20.000
idle12:37:07.166 52.6%200441972 0.103 0.227 0.385
nntp read01:31:41.582 6.4%281641281 0.009 0.020 0.041
overview write00:00:17.222 0.0%2935396 0.001 0.006 0.019
perl filter05:12:02.111 21.7%2937367 4.093 6.374 8.253
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:55.288 0.4%5908644 0.025 0.060 0.099
TOTAL: 24:00:13.06423:03:02.813 96.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.239 0.0%98341 0.000 0.002 0.100
article prepare00:00:00.014 0.0%50036 0.000 0.000 0.062
article read00:00:58.388 0.1%12498 0.000 4.672 373.000
backlog stats00:00:00.209 0.0%246810 0.000 0.001 0.015
callbacks00:00:00.000 0.0%9 0.000 0.000 0.000
data read00:00:01.464 0.0%130435 0.000 0.011 0.067
data write00:00:09.366 0.0%98274 0.000 0.095 1.184
idle23:59:07.309 99.9%246810 78.494 349.853 1072.767
status file00:00:12.849 0.0%15723 0.000 0.817 93.000
TOTAL: 24:00:41.66824:00:29.838100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle08:19:47.457 99.9%97126 0.000 308.748360065.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:09.581 0.0%255532 0.000 0.037 63.077
readart00:00:00.633 0.0%70 0.000 9.043 35.500
TOTAL: 08:20:17.67408:19:57.671 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1334 29378562932307 154 5395 99%339:47:26
2news.nask.pl 2 14547 2836 11368 343 19%23:32:28
3news.icm.edu.pl 44 353 74 161 118 20%16:31:46
4localhost 12 11 11 0 0 100%00:00:01
TOTAL: 4 1392 29527672935228 11683 5856 99%379:51:41
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl824.0 GB317.2 MB566.2 MB824.9 GB 99%294.4 KB
2news.nask.pl10.3 MB1.0 MB1.1 MB12.4 MB 83%4.0 KB
3news.icm.edu.pl3.9 MB23.2 KB3.5 MB7.4 MB 53%39.6 KB
4localhost15.7 KB0.0 KB0.0 KB15.7 KB100%1.4 KB
TOTAL: 4824.0 GB318.3 MB570.8 MB824.9 GB 99%294.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 5 04:15:04 - 04:59:59 75278 2.6% 27.9221.8 GB 2.6%8468.92
Dec 5 05:00:00 - 05:59:59 112580 3.8% 31.2731.7 GB 3.9%9239.16
Dec 5 06:00:00 - 06:59:59 97963 3.3% 27.2128.4 GB 3.4%8260.97
Dec 5 07:00:00 - 07:59:59 103706 3.5% 28.8128.9 GB 3.5%8428.66
Dec 5 08:00:00 - 08:59:59 130563 4.4% 36.2735.9 GB 4.4%10466.76
Dec 5 09:00:00 - 09:59:59 127299 4.3% 35.3635.4 GB 4.3%10320.00
Dec 5 10:00:00 - 10:59:59 131758 4.5% 36.6036.9 GB 4.5%10735.19
Dec 5 11:00:00 - 11:59:59 135574 4.6% 37.6637.2 GB 4.5%10835.32
Dec 5 12:00:00 - 12:59:59 135969 4.6% 37.7737.7 GB 4.6%10983.30
Dec 5 13:00:00 - 13:59:59 140962 4.8% 39.1638.2 GB 4.6%11118.16
Dec 5 14:00:00 - 14:59:59 133588 4.6% 37.1136.7 GB 4.5%10701.38
Dec 5 15:00:00 - 15:59:59 132976 4.5% 36.9436.5 GB 4.4%10645.73
Dec 5 16:00:00 - 16:59:59 121350 4.1% 33.7135.0 GB 4.3%10205.05
Dec 5 17:00:00 - 17:59:59 128848 4.4% 35.7935.9 GB 4.4%10466.28
Dec 5 18:00:00 - 18:59:59 123245 4.2% 34.2334.7 GB 4.2%10093.10
Dec 5 19:00:00 - 19:59:59 134712 4.6% 37.4237.5 GB 4.6%10912.92
Dec 5 20:00:00 - 20:59:59 134894 4.6% 37.4737.8 GB 4.6%11015.02
Dec 5 21:00:00 - 21:59:59 132815 4.5% 36.8936.9 GB 4.5%10755.55
Dec 5 22:00:00 - 22:59:59 141257 4.8% 39.2437.9 GB 4.6%11047.19
Dec 5 23:00:00 - 23:59:59 133067 4.5% 36.9637.1 GB 4.5%10818.58
Dec 6 00:00:00 - 00:59:59 103919 3.5% 28.8730.4 GB 3.7%8862.90
Dec 6 01:00:00 - 01:59:59 103991 3.5% 28.8929.9 GB 3.6%8701.15
Dec 6 02:00:00 - 02:59:59 102873 3.5% 28.5829.8 GB 3.6%8686.42
Dec 6 03:00:00 - 03:59:59 87612 3.0% 24.3426.5 GB 3.2%7730.96
Dec 6 04:00:00 - 04:15:02 28261 1.0% 31.338.2 GB 1.0%9479.50
TOTAL: 23:59:58 2935060 100.0% 33.97823.1 GB 100.0%9989.70
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 5868 197 0 3548 2 0 0 0 2121
2news.nask.pl 372 2 0 334 4 0 0 0 32
3news.icm.edu.pl 119 0 0 2 0 0 0 0 117
TOTAL: 3 6359 199 0 3884 6 0 0 0 2270

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 98
it.comp.os.win.windows10 55
it.comp.os.win.windows7 16
it.tlc.cellulari.android 10
it.comp.os.win.windows8 3
comp.mobile.android 2
hr.ponuda.hardver.konfiguracije 2
comp.sys.raspberry-pi 2
de.comp.lang.vbclassic 1
nl.wetenschap.regulier 1
uk.rec.cycling.moderated 1
nl.gezondheid.alternatief-genezen 1
nl.comp.os.linux.techniek 1
de.comp.lang.perl 1
hr.ponuda.hardver.komponente 1
de.comp.lang.php 1
nl.comp.sys.android 1
nl.actueel 1
comp.mobile.ipad 1
TOTAL: 19 199

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

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

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 1244
EMP (fsl) 408
EMP (md5) 104
Too many newsgroups 10
TOTAL: 4 1766

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 68104 1501 39853 690 34 56229 2%23:59:57
2icm 44225 274 22558 9253 0 9 0%24:03:43
3poznan 4124 86 2672 38 0 0 2%23:54:54
4okapi 0 0 0 0 0 1733 0%24:00:00
5nask 0 0 0 0 0 12804 0%24:00:00
TOTAL: 5 116453 1861 65083 9981 34 70775 1%119:58:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm10.9 MB2.2 GB2.2 GB26.5 KB/s240.5 KB24:03:43
2panorama5.5 MB5.4 MB10.9 MB0.1 KB/s5.1 KB23:59:57
3poznan302.1 KB88.4 KB390.5 KB0.0 KB/s3.1 KB23:54:54
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 516.6 MB2.2 GB2.2 GB5.3 KB/s194.5 KB119:58:34
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1auriga.rz.izeto.pl 2 2537.7 KB 2 0 000:00:06
2195.205.42.6 17 1918.5 KB 3 0 700:51:48
389-65-16-106.dynamic.chello.pl 9 1010.3 KB 5 0 401:43:41
4web.man.lodz.pl 288 684.3 KB 3 0 000:00:31
531.41.177.74 2 55.1 KB 4 0 100:09:40
6wireless.ics.p.lodz.pl 3 54.1 KB 3 2 000:11:48
7isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:00
8176.116.148.12 2 00.0 KB 0 0 100:02:21
TOTAL: 8 332 70160.0 KB 20 11 1308:20:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.rz.izeto.pl 2 2537.7 KB 2 0 000:00:06
2unresolved 23 2423.6 KB 7 0 905:48:31
3*.dynamic.chello.pl 9 1010.3 KB 5 0 401:43:41
4*.man.lodz.pl 681 684.3 KB 3 9 000:00:36
5*.ics.p.lodz.pl 3 54.1 KB 3 2 000:11:48
6*.toya.net.pl 5 00.0 KB 0 0 000:00:31
7*.free.aero2.net.pl 2 00.0 KB 0 0 000:35:01
TOTAL: 7 725 70160.0 KB 20 11 1308:20:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.195.155 4.966 6.316 0.00004:44:40
89-65-16-106.dynamic.chello.pl 0.020 0.118 0.00001:43:41
195.205.42.6 0.147 0.218 0.00000:51:48
ip-5-172-247-254.free.aero2.net.pl 0.059 0.039 0.00000:35:01
wireless.ics.p.lodz.pl 0.158 0.112 0.00000:11:48
31.41.177.74 0.040 0.043 0.00000:09:40
176.116.148.12 0.009 0.022 0.00000:02:21
web.man.lodz.pl 0.878 3.440 0.00000:00:31
staticline-31-183-167-235.toya.net.pl 0.007 0.011 0.00000:00:31
auriga.rz.izeto.pl 0.005 0.020 0.00000:00:06
mon.man.lodz.pl 0.901 3.228 0.00000:00:02
david.man.lodz.pl 0.292 1.099 0.00000:00:00
isvcs01.man.lodz.pl 0.069 0.102 0.00000:00:00
staticline41435.toya.net.pl 0.000 0.047 0.00000:00:00
? 0.004 0.004 0.00000:00:00
TOTAL: 15 7.555 14.819 0.00008:20:17

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 4
ip-5-172-247-254.free.aero2.net.pl 2
185.48.195.155 2
staticline-31-183-167-235.toya.net.pl 1
TOTAL: 6 393

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
89-65-16-106.dynamic.chello.pl 3 0
TOTAL: 1 3 0

Newsgroup request counts (by category):

CategoryCountPct
1lodz 28 40.0%
2lodman 27 38.6%
3pl 11 15.7%
4lodzman 4 5.7%
TOTAL: 4 70100.0%

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

NewsgroupCount
1lodz.test 27
2lodman.info 27
3pl.test 5
4pl.comp.pecet 4
5lodzman.test 4
6pl.comp.os.ms-windows.winnt 2
7lodz.ogloszenia 1
TOTAL: 7 70