Daily Usenet report

Oct 15 04:15:02 -- Oct 16 04:15:02

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Oct 15 11:11:04 newsfeed controlchan[2208]: control_checkgroups, ^.*$ !ka.lists #20131015 usenet@karlsruhe.org usenet@karlsruhe.org @0304425546303500000000CA22CC00000069@, , , utf-8, news.task.gda.pl, mail, 1
Oct 15 11:11:04 newsfeed controlchan[2208]: control_checkgroups, ^.*$ !ka.lists #20131015 usenet@karlsruhe.org usenet@karlsruhe.org @0304425546303500000000CA22CC00000069@, ^.*$, , utf-8, news.task.gda.pl, drop, -1
Oct 15 14:20:24 newsfeed nnrpd[13520]: SERVER perl filter not defined
Oct 15 15:25:28 newsfeed nnrpd[15643]: SERVER perl filter not defined
Oct 15 16:17:30 newsfeed overchan[2219]: input line too long, skipping
Oct 15 17:00:08 newsfeed pgpverify[18592]: pgpverify: verification failed
Oct 15 17:16:40 newsfeed nnrpd[18995]: SERVER perl filter not defined
Oct 15 18:03:41 newsfeed nnrpd[20518]: SERVER perl filter not defined
Oct 15 19:04:40 newsfeed overchan[2219]: input line too long, skipping
Oct 15 22:34:14 newsfeed overchan[2219]: input line too long, skipping
Oct 16 03:03:22 newsfeed overchan[2219]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2079755 98.4%234.3 MB 97.9%
innd 17894 0.8%3.0 MB 1.2%
nnrpd 9242 0.4%974.0 KB 0.4%
innfeed 6915 0.3%1.0 MB 0.4%
controlchan 5 0.0%0.8 KB 0.0%
overchan 4 0.0%0.7 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 72113816 100.0%239.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2072269 94.0%
Negative hits 91150 4.1%
Positive hits 40978 1.9%
Cache misses 272 0.0%
TOTAL: 4 2204669 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:08.435 0.0%335 0.000 25.179 741.000
article cleanup00:00:31.048 0.0%2078845 0.004 0.015 0.027
article logging00:01:21.811 0.1%2079000 0.019 0.039 0.574
article parse01:04:09.108 4.5%63426309 0.028 0.061 0.093
article write00:23:52.215 1.7%2071013 0.440 0.692 1.497
artlog/artcncl00:00:00.008 0.0%335 0.000 0.024 0.500
artlog/artparse00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:02:03.540 0.1%75699389 0.001 0.002 0.004
hisgrep/artcncl00:00:02.278 0.0%267 0.000 8.532 263.000
hishave/artcncl00:00:01.428 0.0%335 0.000 4.263 269.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup03:35:20.169 15.0%2205677 1.495 5.858 39.726
history sync00:00:00.008 0.0%292 0.000 0.027 1.000
history write04:48:46.760 20.1%2073332 1.950 8.357 47.309
hiswrite/artcncl00:00:00.223 0.0%68 0.000 3.279 18.000
idle07:18:36.957 30.5%29988937 0.216 0.878 4.132
nntp read00:38:21.604 2.7%61787698 0.022 0.037 0.049
overview write00:00:13.949 0.0%2071013 0.001 0.007 0.015
perl filter05:38:20.469 23.5%2073329 7.589 9.791 11.502
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:12.643 0.3%4183121 0.021 0.060 0.095
TOTAL: 23:59:37.62023:36:02.653 98.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.165 0.0%41090 0.000 0.004 0.125
article prepare00:00:00.023 0.0%55536 0.000 0.000 0.062
article read00:00:01.377 0.0%13117 0.000 0.105 1.125
backlog stats00:00:00.261 0.0%310284 0.000 0.001 0.028
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.479 0.0%183680 0.000 0.013 1.000
data write00:00:06.623 0.0%160038 0.000 0.041 1.000
idle23:59:09.623100.0%310284 0.000 278.292 17085.000
status file00:00:01.569 0.0%226 0.000 6.942 264.500
TOTAL: 23:59:29.57423:59:22.120100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle32:18:40.950100.0%14989 0.000 7760.421460452.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.596 0.0%32251 0.000 0.018 0.667
readart00:00:01.144 0.0%534 0.000 2.142 27.154
TOTAL: 32:19:14.30132:18:42.690100.0%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 877 20656872058584 2322 4781 99%447:24:04
2news.nask.pl 2 17259 6815 8961 1483 39%23:40:36
3news.task.gda.pl 13 32421 6240 24616 1565 19%46:57:23
4news.icm.edu.pl 40 272 12 238 22 4%18:16:29
5localhost 5 4 4 0 0 100%00:00:01
TOTAL: 5 937 21156432071655 36137 7851 97%536:18:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl739.6 GB14.0 MB30.1 MB739.6 GB 99%375.9 KB
2news.nask.pl21.8 MB4.1 MB4.2 MB30.1 MB 72%3.7 KB
3news.task.gda.pl14.2 MB53.7 KB4.4 MB18.7 MB 76%2.5 KB
4news.icm.edu.pl179.3 KB0.0 KB336.4 KB515.7 KB 34%15.2 KB
5localhost6.3 KB0.0 KB0.0 KB6.3 KB100%1.6 KB
TOTAL: 5739.6 GB18.2 MB39.0 MB739.7 GB 99%373.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 15 04:15:02 - 04:59:59 72618 3.5% 26.9225.9 GB 3.5%10052.53
Oct 15 05:00:00 - 05:59:59 94648 4.6% 26.2935.0 GB 4.7%10206.45
Oct 15 06:00:00 - 06:59:59 74852 3.6% 20.7927.6 GB 3.7%8052.39
Oct 15 07:00:00 - 07:59:59 71576 3.5% 19.8827.2 GB 3.7%7931.26
Oct 15 08:00:00 - 08:59:59 97994 4.7% 27.2235.9 GB 4.9%10469.35
Oct 15 09:00:00 - 09:59:59 81639 3.9% 22.6830.3 GB 4.1%8839.23
Oct 15 10:00:00 - 10:59:59 86285 4.2% 23.9732.7 GB 4.4%9528.44
Oct 15 11:00:00 - 11:59:59 79950 3.9% 22.2129.7 GB 4.0%8663.96
Oct 15 12:00:00 - 12:59:59 92037 4.4% 25.5733.1 GB 4.5%9645.84
Oct 15 13:00:00 - 13:59:59 63070 3.0% 17.5223.9 GB 3.2%6964.95
Oct 15 14:00:00 - 14:59:59 84524 4.1% 23.4829.8 GB 4.0%8691.43
Oct 15 15:00:00 - 15:59:59 80831 3.9% 22.4527.4 GB 3.7%7970.16
Oct 15 16:00:00 - 16:59:59 102079 4.9% 28.3633.9 GB 4.6%9872.41
Oct 15 17:00:00 - 17:59:59 99480 4.8% 27.6334.3 GB 4.6%9986.30
Oct 15 18:00:00 - 18:59:59 108272 5.2% 30.0835.7 GB 4.8%10392.57
Oct 15 19:00:00 - 19:59:59 77114 3.7% 21.4224.9 GB 3.4%7256.94
Oct 15 20:00:00 - 20:59:59 81706 3.9% 22.7029.5 GB 4.0%8580.35
Oct 15 21:00:00 - 21:59:59 78260 3.8% 21.7427.9 GB 3.8%8134.93
Oct 15 22:00:00 - 22:59:59 88034 4.2% 24.4529.4 GB 4.0%8574.65
Oct 15 23:00:00 - 23:59:59 84624 4.1% 23.5128.7 GB 3.9%8367.88
Oct 16 00:00:00 - 00:59:59 76873 3.7% 21.3528.0 GB 3.8%8169.25
Oct 16 01:00:00 - 01:59:59 109311 5.3% 30.3639.5 GB 5.3%11515.80
Oct 16 02:00:00 - 02:59:59 82145 4.0% 22.8229.8 GB 4.0%8682.34
Oct 16 03:00:00 - 03:59:59 81416 3.9% 22.6230.3 GB 4.1%8818.50
Oct 16 04:00:00 - 04:15:02 22091 1.1% 24.498.4 GB 1.1%9744.22
TOTAL: 24:00:00 2071429 100.0% 23.97739.1 GB 100.0%8970.44
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4893 235 0 4016 6 0 0 0 636
2news.task.gda.pl 1545 1288 0 26 0 0 0 0 231
3news.nask.pl 1531 9 0 1473 12 0 0 0 37
4news.icm.edu.pl 22 0 0 0 0 0 0 0 22
TOTAL: 4 7991 1532 0 5515 18 0 0 0 926

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 126
mailing.freebsd.svn-ports-all 110
mailing.freebsd.svn-ports-head 110
mailing.freebsd.svn-src-all 74
fa.freebsd.cvs-all 71
mailing.freebsd.svn-src-head 70
mailing.freebsd.ports-bugs 66
mailing.openbsd.ports-changes 58
mailing.gcc.gcc-cvs 57
fr.rec.loisirs-creatifs 54
alt.politics.scorched-earth 51
alt.windows7.general 44
mailing.openbsd.source-changes 44
mailing.freebsd.ports 41
mozilla.dev.tree-management 38
it.tlc.cellulari.android 32
it.comp.os.win.windows8 30
fr.usenet.abus.nocem 27
24hoursupport.helpdesk 26
mailing.freebsd.kde 25
TOTAL: 72 1532

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

GroupsCount
pl.sci.historia 18
TOTAL: 1 18

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 533
EMP (fsl) 194
EMP (md5) 20
HTML post 12
Scoring filter (9) 6
Scoring filter (11) 3
TOTAL: 6 768

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 58446 5007 30472 3988 6 1 8%23:56:20
2panorama 42152 3771 36367 906 0 0 8%23:56:33
3poznan 15280 75 12632 47 0 0 0%23:52:54
4task 2296 42 1198 5 0 0 1%22:00:02
5nask 16989 13 12301 1 0 0 0%23:57:20
6okapi 0 0 0 0 0 3120 0%24:00:00
TOTAL: 6 135163 8908 92970 4947 6 3121 6%141:43:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm27.1 MB1.2 GB1.2 GB15.1 KB/s144.7 KB23:56:20
2panorama10.4 MB3.5 MB13.9 MB0.2 KB/s3.0 KB23:56:33
3poznan256.2 KB121.9 KB378.1 KB0.0 KB/s3.1 KB23:52:54
4task102.6 KB9.2 KB111.8 KB0.0 KB/s2.4 KB22:00:02
5nask49.2 KB1.4 KB50.6 KB0.0 KB/s3.6 KB23:57:20
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 637.9 MB1.2 GB1.3 GB2.6 KB/s95.0 KB141:43:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 312438.5 KB 288 0 000:00:09
2212.191.78.190 194 113212.9 KB 49 2 029:11:55
3web.man.lodz.pl 288 106112.4 KB 45 0 000:00:25
4router2.cbmm.lodz.pl 6 22.5 KB 1 0 000:15:45
5ip-176.105.135.22.tvsat364.lodz.pl 6 11.3 KB 1 0 001:49:58
6kujawiak.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 6 784 534767.7 KB 384 4 032:19:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 312438.5 KB 288 0 000:00:09
2unresolved 197 113212.9 KB 49 2 029:22:10
3*.man.lodz.pl 674 106112.4 KB 45 2 000:00:37
4*.cbmm.lodz.pl 6 22.5 KB 1 0 000:15:45
5*.105.135.22.tvsat364.lodz.pl 6 11.3 KB 1 0 001:49:58
6*.105.140.86.tvsat364.lodz.pl 2 00.0 KB 0 0 000:00:23
7*.191.14.62.static.jazztel.es 4 00.0 KB 0 0 000:19:09
8*.neoplus.adsl.tpnet.pl 1 00.0 KB 0 0 000:00:51
9*.toya.net.pl 78 00.0 KB 0 0 000:30:06
TOTAL: 91256 534767.7 KB 384 4 032:19:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.620 3.344 0.00029:11:55
ip-176.105.135.22.tvsat364.lodz.pl 0.016 0.116 0.00001:49:58
staticline-31-182-149-111.toya.net.pl 0.032 0.028 0.00000:30:01
16.191.14.62.static.jazztel.es 0.596 0.916 0.00000:19:09
router2.cbmm.lodz.pl 0.032 0.096 0.00000:15:45
194.28.49.102 0.028 0.024 0.00000:10:02
ecf53.neoplus.adsl.tpnet.pl 0.000 0.020 0.00000:00:51
web.man.lodz.pl 0.796 5.176 0.00000:00:25
ip-176.105.140.86.tvsat364.lodz.pl 0.008 0.032 0.00000:00:23
212.51.203.199 0.004 0.036 0.00000:00:12
vegas.cm.p.lodz.pl 0.708 5.076 0.00000:00:09
f-oper-v100.man.lodz.pl 0.736 5.416 0.00000:00:07
staticline41435.toya.net.pl 0.204 1.336 0.00000:00:04
david.man.lodz.pl 0.288 1.864 0.00000:00:03
kujawiak.man.lodz.pl 0.012 0.040 0.00000:00:00
TOTAL: 15 4.080 23.520 0.00032:19:13

Curious NNRP server explorers [Top 20]:

SystemConn
f-oper-v100.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 77
16.191.14.62.static.jazztel.es 4
ip-176.105.140.86.tvsat364.lodz.pl 2
212.51.203.199 2
ecf53.neoplus.adsl.tpnet.pl 1
staticline-31-182-149-111.toya.net.pl 1
194.28.49.102 1
TOTAL: 9 472

NNRP client timeouts [Top 20]:

SystemConnPeer
16.191.14.62.static.jazztel.es 1 1
ip-176.105.135.22.tvsat364.lodz.pl 1 0
staticline-31-182-149-111.toya.net.pl 1 0
TOTAL: 3 3 1

Newsgroup request counts (by category):

CategoryCountPct
1lodman 312 58.4%
2pl 222 41.6%
TOTAL: 2 534100.0%

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

NewsgroupCount
1lodman.info 312
2pl.comp.pecet 66
3pl.comp.os.ms-windows.winnt 40
4pl.misc.kolej 30
5pl.rec.rowery 26
6pl.soc.prawo 21
7pl.comp.os.linux 15
8pl.regionalne.warszawa 10
9pl.rec.gory 7
10pl.regionalne.lodz 6
11pl.praca.dyskusje 1
TOTAL: 11 534