Daily Usenet report

Mar 15 04:15:02 -- Mar 16 04:15:04

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Mar 15 11:11:05 newsfeed controlchan[2298]: control_checkgroups, ^.*$ !ka.lists #20140315 usenet@karlsruhe.org usenet@karlsruhe.org @03044255463035000000015722AB0000006C@, , , utf-8, news.task.gda.pl, mail, 1
Mar 15 11:11:06 newsfeed controlchan[2298]: control_checkgroups, ^.*$ !ka.lists #20140315 usenet@karlsruhe.org usenet@karlsruhe.org @03044255463035000000015722AB0000006C@, ^.*$, , utf-8, news.task.gda.pl, drop, -1
Mar 15 16:00:07 newsfeed pgpverify[16785]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn1741194 98.3%199.8 MB 97.9%
innd 15207 0.9%2.6 MB 1.3%
innfeed 7074 0.4%1.1 MB 0.5%
nnrpd 6934 0.4%719.7 KB 0.3%
controlchan 5 0.0%0.8 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 61770415 100.0%204.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1736533 96.5%
Negative hits 33624 1.9%
Positive hits 28880 1.6%
Cache misses 298 0.0%
TOTAL: 4 1799335 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:17.544 0.0%215 0.000 81.600 567.000
article cleanup00:00:23.001 0.0%1740105 0.001 0.013 0.031
article logging00:00:50.023 0.1%1740217 0.007 0.029 0.442
article parse00:46:12.014 3.2%244280997 0.003 0.011 0.035
article write00:13:51.109 1.0%1735851 0.123 0.479 1.687
artlog/artcncl00:00:00.004 0.0%214 0.000 0.019 1.000
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:02:28.662 0.2%256035183 0.000 0.001 0.029
hisgrep/artcncl00:00:03.684 0.0%196 0.000 18.796 270.000
hishave/artcncl00:00:00.281 0.0%215 0.000 1.307 18.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:08:39.407 4.8%1800198 0.490 2.288 6.165
history sync00:00:00.014 0.0%291 0.000 0.048 1.000
history write03:43:03.897 15.5%1737518 3.662 7.703 23.423
hiswrite/artcncl00:00:00.114 0.0%19 0.000 6.000 18.000
idle13:08:05.862 54.7%187986470 0.084 0.252 0.737
nntp read00:52:21.169 3.6%243080794 0.005 0.013 0.029
overview write00:00:09.608 0.0%1735851 0.000 0.006 0.017
perl filter03:10:12.156 13.2%1737510 2.164 6.568 9.476
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:13.078 0.2%3503859 0.022 0.055 0.364
TOTAL: 23:59:28.68923:09:51.627 96.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.102 0.0%32188 0.000 0.003 0.111
article prepare00:00:00.005 0.0%32844 0.000 0.000 0.125
article read00:00:01.380 0.0%7919 0.000 0.174 30.875
backlog stats00:00:00.191 0.0%261004 0.000 0.001 0.013
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.507 0.0%149877 0.000 0.010 0.078
data write00:00:05.931 0.0%129521 0.000 0.046 1.000
idle23:59:56.202100.0%261004 0.000 331.015 23277.000
status file00:00:01.492 0.0%260 0.000 5.738 145.500
TOTAL: 24:00:14.54524:00:06.810100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:29:44.109 99.8%4001 0.000 4045.016210044.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.298 0.0%9583 0.000 0.031 5.111
readart00:00:00.028 0.0%346 0.000 0.081 1.000
TOTAL: 04:30:20.18704:29:44.435 99.8%----

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
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 582 17297241726847 36 2841 99%232:34:00
2news.task.gda.pl 24 24266 7505 15697 1064 30%44:08:29
3news.nask.pl 2 13497 2525 10624 348 18%24:14:11
4news.icm.edu.pl 46 232 3 209 20 1%16:05:26
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 655 17677191736880 26566 4273 98%317:02:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl543.3 GB17.1 MB80.5 MB543.4 GB 99%329.4 KB
2news.task.gda.pl13.5 MB46.0 KB3.0 MB16.6 MB 81%2.0 KB
3news.nask.pl11.9 MB1.8 MB1.8 MB15.6 MB 76%5.6 KB
4news.icm.edu.pl122.7 KB9.9 KB199.2 KB331.9 KB 36%14.4 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 5543.3 GB18.9 MB85.6 MB543.4 GB 99%327.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 15 04:15:02 - 04:59:59 71332 4.1% 26.4423.1 GB 4.2%8968.81
Mar 15 05:00:00 - 05:59:59 104866 6.0% 29.1331.5 GB 5.8%9178.81
Mar 15 06:00:00 - 06:59:59 83948 4.8% 23.3230.1 GB 5.5%8761.67
Mar 15 07:00:00 - 07:59:59 95975 5.5% 26.6633.6 GB 6.2%9780.98
Mar 15 08:00:00 - 08:59:59 98663 5.7% 27.4133.1 GB 6.1%9633.68
Mar 15 09:00:00 - 09:59:59 98263 5.7% 27.3034.3 GB 6.3%9997.37
Mar 15 10:00:00 - 10:59:59 70130 4.0% 19.4821.5 GB 4.0%6272.45
Mar 15 11:00:00 - 11:59:59 98366 5.7% 27.3230.9 GB 5.7%8990.76
Mar 15 12:00:00 - 12:59:59 98671 5.7% 27.4130.6 GB 5.6%8917.73
Mar 15 13:00:00 - 13:59:59 64687 3.7% 17.9716.7 GB 3.1%4876.13
Mar 15 14:00:00 - 14:59:59 52146 3.0% 14.4814.4 GB 2.6%4183.39
Mar 15 15:00:00 - 15:59:59 48245 2.8% 13.4015.0 GB 2.8%4382.56
Mar 15 16:00:00 - 16:59:59 52817 3.0% 14.6715.5 GB 2.9%4515.85
Mar 15 17:00:00 - 17:59:59 46460 2.7% 12.9114.7 GB 2.7%4274.05
Mar 15 18:00:00 - 18:59:59 64123 3.7% 17.8115.8 GB 2.9%4589.54
Mar 15 19:00:00 - 19:59:59 49658 2.9% 13.7914.7 GB 2.7%4272.92
Mar 15 20:00:00 - 20:59:59 45392 2.6% 12.6113.7 GB 2.5%3982.21
Mar 15 21:00:00 - 21:59:59 44030 2.5% 12.2313.3 GB 2.5%3887.53
Mar 15 22:00:00 - 22:59:59 38496 2.2% 10.6911.3 GB 2.1%3305.00
Mar 15 23:00:00 - 23:59:59 48621 2.8% 13.5115.5 GB 2.9%4520.59
Mar 16 00:00:00 - 00:59:59 89755 5.2% 24.9327.3 GB 5.0%7965.04
Mar 16 01:00:00 - 01:59:59 78797 4.5% 21.8924.6 GB 4.5%7166.41
Mar 16 02:00:00 - 02:59:59 80736 4.6% 22.4325.6 GB 4.7%7467.69
Mar 16 03:00:00 - 03:59:59 87448 5.0% 24.2928.5 GB 5.2%8287.30
Mar 16 04:00:00 - 04:15:04 24977 1.4% 27.638.3 GB 1.5%9652.11
TOTAL: 24:00:02 1736602 100.0% 20.10543.7 GB 100.0%6597.97
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 2939 143 0 2231 3 0 0 0 562
2news.task.gda.pl 1064 736 0 26 0 0 0 0 302
3news.nask.pl 355 9 0 337 2 0 0 0 7
4news.icm.edu.pl 20 0 0 1 0 0 0 0 19
TOTAL: 4 4378 888 0 2595 5 0 0 0 890

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 113
mailing.freebsd.svn-ports-head 113
mailing.freebsd.ports-bugs 57
uk.railway 50
mailing.openbsd.source-changes 36
mailing.freebsd.ports 34
alt.windows7.general 31
it.comp.os.win.windows8 25
mailing.freebsd.svn-src-all 23
24hoursupport.helpdesk 23
fa.freebsd.cvs-all 23
mozilla.dev.tree-management 22
alt.politics.scorched-earth 19
mailing.freebsd.svn-src-head 19
mailing.gcc.gcc-cvs 18
mailing.openbsd.ports-changes 18
mailing.dragonflybsd.commits 18
mailing.postfix.users 15
mailing.openbsd.misc 14
gmane.linux.alsa.devel 13
TOTAL: 65 888

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

GroupsCount
pl.sci.matematyka 3
pl.sci.historia 2
TOTAL: 2 5

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 402
EMP (fsl) 171
EMP (phl) 116
Attached HTML file 46
EMP (md5) 32
HTML post 2
Scoring filter (8) 1
TOTAL: 7 770

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 49787 4199 25739 1870 0 16 8%24:00:07
2panorama 37223 1587 30360 300 0 1 4%24:06:34
3nask 19542 155 11531 0 0 1 0%24:01:36
4task 1214 75 599 5 0 4 6%20:05:38
5poznan 11111 13 9905 3 0 0 0%23:59:57
6okapi 0 0 0 0 0 1417 0%24:00:02
TOTAL: 6 118877 6029 78134 2178 0 1439 5%140:13:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm530.0 MB266.9 MB796.9 MB9.4 KB/s134.5 KB24:00:07
2panorama8.7 MB1.9 MB10.6 MB0.1 KB/s5.7 KB24:06:34
3nask956.2 KB0.0 KB956.2 KB0.0 KB/s6.2 KB24:01:36
4task147.7 KB10.7 KB158.4 KB0.0 KB/s2.0 KB20:05:38
5poznan26.7 KB16.0 KB42.7 KB0.0 KB/s2.7 KB23:59:57
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
TOTAL: 6539.8 MB268.8 MB808.6 MB1.6 KB/s100.9 KB140:13:54
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 288567.0 KB 288 0 000:00:24
2web.man.lodz.pl 288 5858.5 KB 25 0 000:00:21
TOTAL: 2 576 346625.5 KB 313 0 004:30:19

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 288567.0 KB 288 0 000:00:24
2*.man.lodz.pl 672 5858.5 KB 25 0 000:00:27
3*.neoplus.adsl.tpnet.pl 1 00.0 KB 0 0 000:03:19
4unresolved 1 00.0 KB 0 0 000:00:00
5*.105.135.22.tvsat364.lodz.pl 1 00.0 KB 0 0 000:08:06
6*.wroclaw.mm.pl 26 00.0 KB 0 0 004:18:00
7*.toya.net.pl 5 00.0 KB 0 0 000:00:01
TOTAL: 7 994 346625.5 KB 313 0 004:30:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
host-89-231-50-15.wroclaw.mm.pl 0.040 0.356 0.00004:18:00
ip-176.105.135.22.tvsat364.lodz.pl 0.008 0.012 0.00000:08:06
ebq223.neoplus.adsl.tpnet.pl 0.000 0.016 0.00000:03:19
vegas.cm.p.lodz.pl 0.484 3.960 0.00000:00:24
web.man.lodz.pl 0.596 4.208 0.00000:00:21
mon.man.lodz.pl 0.484 3.828 0.00000:00:04
staticline41435.toya.net.pl 0.008 0.092 0.00000:00:01
david.man.lodz.pl 0.192 1.304 0.00000:00:01
31.135.21.115 0.012 0.012 0.00000:00:00
TOTAL: 9 1.824 13.788 0.00004:30:19

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
host-89-231-50-15.wroclaw.mm.pl 26
staticline41435.toya.net.pl 5
31.135.21.115 1
ip-176.105.135.22.tvsat364.lodz.pl 1
ebq223.neoplus.adsl.tpnet.pl 1
TOTAL: 7 418

Newsgroup request counts (by category):

CategoryCountPct
1lodman 288 83.2%
2pl 58 16.8%
TOTAL: 2 346100.0%

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

NewsgroupCount
1lodman.info 288
2pl.comp.pecet 44
3pl.comp.os.ms-windows.winnt 14
TOTAL: 3 346