Daily Usenet report

Aug 5 04:15:03 -- Aug 6 04:15:03

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 5 18:01:40 newsfeed nnrpd[10033]: SERVER perl filter not defined
Aug 5 21:22:22 newsfeed nnrpd[16338]: SERVER perl filter not defined
Aug 5 23:06:40 newsfeed nnrpd[19714]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2257531 98.6%255.9 MB 98.1%
innd 18651 0.8%3.1 MB 1.2%
innfeed 7325 0.3%1.1 MB 0.4%
nnrpd 7010 0.3%742.5 KB 0.3%
controlchan 2 0.0%0.4 KB 0.0%
TOTAL: 52290519 100.0%260.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2253249 94.7%
Negative hits 85648 3.6%
Positive hits 36989 1.6%
Cache misses 2544 0.1%
TOTAL: 4 2378430 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:12.251 0.0%369 0.000 33.201 585.000
article cleanup00:00:29.738 0.0%2258504 0.005 0.013 0.025
article logging00:01:12.065 0.1%2258664 0.011 0.032 0.999
article parse01:19:07.138 5.5%98550729 0.013 0.048 0.096
article write00:24:38.389 1.7%2253991 0.427 0.656 1.733
artlog/artcncl00:00:00.146 0.0%350 0.000 0.417 141.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:02:28.195 0.2%112716854 0.000 0.001 0.007
hisgrep/artcncl00:00:02.348 0.0%313 0.000 7.502 286.000
hishave/artcncl00:00:00.847 0.0%369 0.000 2.295 248.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:38:45.552 11.0%2381253 0.738 4.000 15.099
history sync00:00:00.010 0.0%293 0.000 0.034 1.000
history write03:59:28.030 16.6%2256023 2.903 6.369 30.801
hiswrite/artcncl00:00:00.599 0.0%56 0.000 10.696 253.000
idle08:14:28.032 34.3%61916150 0.149 0.479 1.552
nntp read00:46:29.754 3.2%96712099 0.011 0.029 0.053
overview write00:00:13.666 0.0%2253991 0.001 0.006 0.015
perl filter05:58:29.173 24.9%2256022 5.316 9.534 11.515
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:41.908 0.3%4548688 0.015 0.049 0.081
TOTAL: 24:00:43.14923:29:47.841 97.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.153 0.0%40680 0.000 0.004 0.100
article prepare00:00:00.010 0.0%30678 0.000 0.000 0.083
article read00:00:00.407 0.0%7469 0.000 0.054 1.000
backlog stats00:00:00.208 0.0%294838 0.000 0.001 0.029
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.812 0.0%178000 0.000 0.010 0.070
data write00:00:04.056 0.0%142772 0.000 0.028 0.333
idle23:59:55.441100.0%294838 0.000 293.027 13284.000
status file00:00:00.759 0.0%232 0.000 3.272 84.200
TOTAL: 24:00:09.00024:00:02.846100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:11.998 0.0%227809 0.043 0.053 0.057
idle26:14:58.670 99.8%711983 0.000 132.726600054.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:22.841 0.0%1425791 0.000 0.016 0.556
readart00:01:05.381 0.1%228099 0.000 0.287 40.154
TOTAL: 26:17:38.77026:16:38.890 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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
koordination@cl-netz.de001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 812 22493902239733 7069 2588 99%368:55:51
2news.nask.pl 2 16320 7098 8438 784 43%24:00:50
3news.task.gda.pl 16 28885 5245 22467 1173 18%48:21:21
4news.icm.edu.pl 47 256 5 229 22 1%17:40:30
5localhost 4 3 3 0 0 100%00:00:01
TOTAL: 5 881 22948542252084 38203 4567 98%458:58:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl824.5 GB11.1 MB50.2 MB824.6 GB 99%385.6 KB
2news.nask.pl22.4 MB1.9 MB2.0 MB26.2 MB 85%3.4 KB
3news.task.gda.pl11.9 MB36.4 KB3.4 MB15.3 MB 77%2.4 KB
4news.icm.edu.pl120.4 KB41.2 KB303.4 KB465.0 KB 25%17.2 KB
5localhost4.1 KB0.0 KB0.0 KB4.1 KB100%1.4 KB
TOTAL: 5824.6 GB13.1 MB55.9 MB824.6 GB 99%383.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 5 04:15:03 - 04:59:59 67644 3.0% 25.0825.2 GB 3.1%9788.28
Aug 5 05:00:00 - 05:59:59 99174 4.4% 27.5535.9 GB 4.3%10443.07
Aug 5 06:00:00 - 06:59:59 91489 4.1% 25.4134.2 GB 4.2%9971.79
Aug 5 07:00:00 - 07:59:59 94241 4.2% 26.1835.5 GB 4.3%10349.03
Aug 5 08:00:00 - 08:59:59 100847 4.5% 28.0135.9 GB 4.4%10461.01
Aug 5 09:00:00 - 09:59:59 97526 4.3% 27.0935.0 GB 4.2%10201.69
Aug 5 10:00:00 - 10:59:59 92516 4.1% 25.7034.8 GB 4.2%10130.42
Aug 5 11:00:00 - 11:59:59 91164 4.0% 25.3235.0 GB 4.3%10207.05
Aug 5 12:00:00 - 12:59:59 93159 4.1% 25.8835.3 GB 4.3%10285.22
Aug 5 13:00:00 - 13:59:59 97892 4.3% 27.1935.2 GB 4.3%10241.45
Aug 5 14:00:00 - 14:59:59 97538 4.3% 27.0933.7 GB 4.1%9826.72
Aug 5 15:00:00 - 15:59:59 91682 4.1% 25.4731.5 GB 3.8%9188.07
Aug 5 16:00:00 - 16:59:59 94755 4.2% 26.3231.9 GB 3.9%9299.85
Aug 5 17:00:00 - 17:59:59 103493 4.6% 28.7534.8 GB 4.2%10136.83
Aug 5 18:00:00 - 18:59:59 92047 4.1% 25.5731.8 GB 3.9%9269.87
Aug 5 19:00:00 - 19:59:59 91136 4.0% 25.3232.7 GB 4.0%9533.48
Aug 5 20:00:00 - 20:59:59 91573 4.1% 25.4434.1 GB 4.1%9935.43
Aug 5 21:00:00 - 21:59:59 91404 4.1% 25.3934.3 GB 4.2%9992.44
Aug 5 22:00:00 - 22:59:59 91174 4.0% 25.3333.9 GB 4.1%9882.85
Aug 5 23:00:00 - 23:59:59 99977 4.4% 27.7737.2 GB 4.5%10841.69
Aug 6 00:00:00 - 00:59:59 87049 3.9% 24.1832.8 GB 4.0%9558.10
Aug 6 01:00:00 - 01:59:59 96340 4.3% 26.7635.7 GB 4.3%10390.94
Aug 6 02:00:00 - 02:59:59 81923 3.6% 22.7631.9 GB 3.9%9288.10
Aug 6 03:00:00 - 03:59:59 97499 4.3% 27.0837.8 GB 4.6%11003.13
Aug 6 04:00:00 - 04:15:03 19265 0.9% 21.338.0 GB 1.0%9263.54
TOTAL: 24:00:00 2252507 100.0% 26.07824.3 GB 100.0%10003.95
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 2696 271 0 1718 0 0 0 0 707
2news.task.gda.pl 1131 939 0 17 6 0 0 0 169
3news.nask.pl 825 21 0 742 4 0 0 0 58
4news.icm.edu.pl 22 0 0 2 0 0 0 0 20
TOTAL: 4 4674 1231 0 2479 10 0 0 0 954

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 181
mailing.freebsd.ports-bugs 68
mailing.unix.dovecot 63
gmane.linux.alsa.devel 62
alt.windows7.general 58
fr.usenet.abus.nocem 46
mailing.freebsd.current 45
mailing.freebsd.svn-ports-all 44
mailing.freebsd.svn-ports-head 44
mailing.gcc.gcc-cvs 36
mailing.postfix.users 33
mailing.database.pgsql-general 28
mailing.unix.samba-technical 27
mailing.freebsd.ports 24
uk.rec.cycling.moderated 21
mailing.dragonflybsd.commits 21
mailing.openbsd.source-changes 21
mailing.freebsd.svn-src-all 21
fa.freebsd.cvs-all 21
mailing.unix.samba 20
TOTAL: 78 1231

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

GroupsCount
fr.bienvenue 5
pl.sci.historia 3
fr.comp.securite 1
bit.listserv.catholic 1
TOTAL: 4 10

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 561
EMP (fsl) 142
Attached HTML file 46
EMP (md5) 31
HTML post 10
Scoring filter (8) 1
Scoring filter (12) 1
TOTAL: 7 792

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 44425 3421 36260 1133 1 1 7%24:00:11
2icm 55661 453 31956 2511 0 6 0%23:55:29
3task 1918 72 987 5 0 1 3%22:03:18
4poznan 14579 68 11936 40 0 0 0%24:00:13
5nask 18618 1 13207 0 0 0 0%24:01:57
6okapi 0 0 0 0 0 2572 0%24:00:02
TOTAL: 6 135201 4015 94346 3689 1 2580 2%142:01:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm17.8 MB328.4 MB346.1 MB4.1 KB/s119.6 KB23:55:29
2panorama9.7 MB11.4 MB21.1 MB0.2 KB/s4.7 KB24:00:11
3poznan199.6 KB81.4 KB281.0 KB0.0 KB/s2.6 KB24:00:13
4task135.5 KB12.1 KB147.6 KB0.0 KB/s1.9 KB22:03:18
5nask3.8 KB0.0 KB3.8 KB0.0 KB/s3.8 KB24:01:57
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
TOTAL: 627.8 MB339.8 MB367.6 MB0.7 KB/s48.9 KB142:01:10
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 324542.4 KB 288 0 000:00:09
2web.man.lodz.pl 288 9486.4 KB 42 0 000:00:23
3lze200.lze.lodz.pl 9 4476.6 KB 7 0 001:12:44
4kujawiak.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 4 588 462705.5 KB 337 3 026:17:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 324542.4 KB 288 0 000:00:09
2*.man.lodz.pl 675 9486.4 KB 42 3 000:00:33
3*.lze.lodz.pl 9 4476.6 KB 7 0 001:12:44
4*.191.14.62.static.jazztel.es 1 00.0 KB 0 0 024:19:38
5*.neoplus.adsl.tpnet.pl 6 00.0 KB 0 0 000:44:31
6*.internetdsl.tpnet.pl 2 00.0 KB 0 0 000:00:00
7*.toya.net.pl 1 00.0 KB 0 0 000:00:01
TOTAL: 7 982 462705.5 KB 337 3 026:17:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
158.191.14.62.static.jazztel.es 40.214 127.880 0.00024:19:38
lze200.lze.lodz.pl 0.036 0.148 0.00001:12:44
eck66.neoplus.adsl.tpnet.pl 0.020 0.064 0.00000:42:42
eci163.neoplus.adsl.tpnet.pl 0.000 0.016 0.00000:01:48
web.man.lodz.pl 0.712 4.012 0.00000:00:23
vegas.cm.p.lodz.pl 0.760 4.012 0.00000:00:09
f-oper-v100.man.lodz.pl 0.716 4.100 0.00000:00:07
david.man.lodz.pl 0.204 1.296 0.00000:00:01
staticline43485.toya.net.pl 0.000 0.016 0.00000:00:01
gcq193.internetdsl.tpnet.pl 0.004 0.032 0.00000:00:00
kujawiak.man.lodz.pl 0.028 0.044 0.00000:00:00
? 0.004 0.008 0.00000:00:00
TOTAL: 12 42.698 141.628 0.00026:17:38

Curious NNRP server explorers [Top 20]:

SystemConn
f-oper-v100.man.lodz.pl 288
david.man.lodz.pl 96
eck66.neoplus.adsl.tpnet.pl 5
gcq193.internetdsl.tpnet.pl 2
eci163.neoplus.adsl.tpnet.pl 1
158.191.14.62.static.jazztel.es 1
staticline43485.toya.net.pl 1
TOTAL: 7 394

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
lze200.lze.lodz.pl 2 0
eck66.neoplus.adsl.tpnet.pl 1 0
158.191.14.62.static.jazztel.es 1 1
TOTAL: 3 4 1

Newsgroup request counts (by category):

CategoryCountPct
1lodman 324 70.1%
2pl 138 29.9%
TOTAL: 2 462100.0%

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

NewsgroupCount
1lodman.info 324
2pl.comp.pecet 91
3pl.comp.os.ms-windows.winnt 34
4pl.rec.gory 7
5pl.comp.os.linux.sieci 6
TOTAL: 5 462