Daily Usenet report

Feb 9 04:15:03 -- Feb 10 04:15:02

Unknown entries from news log file:

First 44 / 44 lines (100.0%)

Feb 9 06:40:28 newsfeed nnrpd[14552]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14771]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14772]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14773]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14775]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14777]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14774]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14778]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14779]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14780]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14781]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14782]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14784]: load 62.00 > 16
Feb 9 06:40:31 newsfeed nnrpd[14783]: load 62.00 > 16
Feb 9 06:41:57 newsfeed nnrpd[14969]: mon.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:43:52 newsfeed nnrpd[14994]: david.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:44:09 newsfeed nnrpd[14995]: 64.207.15.62.static.jazztel.es rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:45:01 newsfeed nnrpd[15030]: vegas.cm.p.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:45:01 newsfeed nnrpd[15031]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:45:01 newsfeed nnrpd[15032]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:45:01 newsfeed nnrpd[15034]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:45:01 newsfeed nnrpd[15036]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:45:01 newsfeed nnrpd[15037]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:45:01 newsfeed nnrpd[15038]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:45:01 newsfeed nnrpd[15039]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:46:57 newsfeed nnrpd[15064]: mon.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:47:59 newsfeed nnrpd[15103]: 212.191.78.190 rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:48:00 newsfeed nnrpd[15108]: 212.191.78.190 rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:49:10 newsfeed nnrpd[15113]: 64.207.15.62.static.jazztel.es rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:50:01 newsfeed nnrpd[15150]: vegas.cm.p.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:50:03 newsfeed nnrpd[15164]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:50:03 newsfeed nnrpd[15165]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:50:03 newsfeed nnrpd[15166]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:50:03 newsfeed nnrpd[15167]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:50:03 newsfeed nnrpd[15168]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:50:04 newsfeed nnrpd[15169]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 06:50:04 newsfeed nnrpd[15170]: web.man.lodz.pl rejected loadav [innwatch:hiload] 6200 gt 2000
Feb 9 09:04:57 newsfeed overchan[2187]: input line too long, skipping
Feb 9 14:47:11 newsfeed innfeed[2238]: task:0 connect: Network is unreachable
Feb 9 14:47:11 newsfeed innfeed[2238]: nask:0 connect: Network is unreachable
Feb 9 14:47:11 newsfeed innfeed[2238]: icm:0 connect: Network is unreachable
Feb 10 01:32:33 newsfeed pgpverify[23969]: pgpverify: verification failed
Feb 10 01:32:33 newsfeed pgpverify[23975]: pgpverify: verification failed
Feb 10 01:32:33 newsfeed pgpverify[23981]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn1390142 98.0%159.8 MB 97.5%
innd 13781 1.0%2.3 MB 1.4%
nnrpd 8386 0.6%867.4 KB 0.5%
innfeed 6916 0.5%1.0 MB 0.6%
controlchan 6 0.0%0.6 KB 0.0%
pgpverify 3 0.0%0.5 KB 0.0%
overchan 1 0.0%0.2 KB 0.0%
TOTAL: 71419235 100.0%163.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1385178 93.5%
Negative hits 54538 3.7%
Positive hits 40479 2.7%
Cache misses 955 0.1%
TOTAL: 4 1481150 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:11.445 0.0%525 0.000 21.800 628.000
article cleanup00:00:21.461 0.0%1390114 0.000 0.015 0.046
article logging00:00:42.376 0.0%1390254 0.000 0.030 0.384
article parse00:53:07.117 3.7%154122736 0.000 0.021 0.083
article write00:15:32.886 1.1%1384842 0.222 0.674 36.477
artlog/artcncl00:00:00.009 0.0%514 0.000 0.018 1.000
artlog/artparse00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:03:04.466 0.2%163265112 0.000 0.001 0.022
hisgrep/artcncl00:00:02.332 0.0%365 0.000 6.389 291.000
hishave/artcncl00:00:01.393 0.0%525 0.000 2.653 74.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:26:53.792 10.2%1483100 0.011 5.943 40.576
history sync00:00:00.013 0.0%295 0.000 0.044 1.000
history write03:53:00.565 16.2%1386764 0.305 10.081 3230.082
hiswrite/artcncl00:00:02.540 0.0%160 0.000 15.875 324.000
idle11:48:43.998 49.2%117611365 0.124 0.362 60060.000
nntp read00:53:31.163 3.7%153084371 0.000 0.021 0.043
overview write00:00:09.057 0.0%1384842 0.000 0.007 0.019
perl filter03:13:52.914 13.5%1386756 1.000 8.389 11.217
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:02:55.238 0.2%2818570 0.014 0.062 0.170
TOTAL: 23:59:28.80223:32:12.765 98.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.206 0.0%49378 0.000 0.004 0.091
article prepare00:00:00.029 0.0%87000 0.000 0.000 0.042
article read00:00:06.654 0.0%21355 0.000 0.312 41.750
backlog stats00:00:00.254 0.0%368250 0.000 0.001 0.009
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:02.409 0.0%215167 0.000 0.011 0.066
data write00:00:09.135 0.0%191056 0.000 0.048 1.000
idle23:28:25.456 97.9%368250 0.000 229.478 30100.000
status file00:28:48.773 2.0%294 0.000 5880.1801726097.000
TOTAL: 23:58:26.94023:57:32.916 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle33:03:52.794 99.0%156445 0.000 760.860450765.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:18:25.518 0.9%314806 0.000 3.512 7.642
readart00:00:00.294 0.0%401 0.000 0.733 45.000
TOTAL: 33:23:01.57133:22:18.606100.0%----

Control commands to INND:

CommandNumber
L 1
flush 24
flushlogs 2
go 3
logmode 2
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
throttle 2
TOTAL: 12 191

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de000300
TOTAL000300

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 692 13764941371885 1254 3355 99%282:12:06
2news.task.gda.pl 17 31100 7446 22389 1265 23%38:13:59
3news.nask.pl 6 18938 4380 13925 633 23%24:28:15
4news.icm.edu.pl 42 336 52 254 30 15%19:15:47
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 758 14268681383763 37822 5283 96%364:10:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl449.2 GB73.8 MB126.3 MB449.4 GB 99%342.6 KB
2news.nask.pl21.0 MB2.7 MB2.7 MB26.3 MB 79%5.4 KB
3news.task.gda.pl14.0 MB126.3 KB3.6 MB17.6 MB 79%2.1 KB
4news.icm.edu.pl2.4 MB662.8 KB1.3 MB4.3 MB 55%53.5 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 5449.2 GB77.2 MB133.9 MB449.4 GB 99%339.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 9 04:15:03 - 04:59:59 56403 4.1% 20.9117.2 GB 3.8%6671.00
Feb 9 05:00:00 - 05:59:59 72319 5.2% 20.0925.9 GB 5.8%7534.14
Feb 9 06:00:00 - 06:59:59 12161 0.9% 3.384.1 GB 0.9%1202.75
Feb 9 07:00:00 - 07:59:59 73610 5.3% 20.4527.4 GB 6.1%7980.10
Feb 9 08:00:00 - 08:59:59 70088 5.1% 19.4725.4 GB 5.7%7400.49
Feb 9 09:00:00 - 09:59:59 72356 5.2% 20.1025.6 GB 5.7%7453.54
Feb 9 10:00:00 - 10:59:59 71953 5.2% 19.9924.8 GB 5.5%7235.76
Feb 9 11:00:00 - 11:59:59 35773 2.6% 9.9412.9 GB 2.9%3762.78
Feb 9 12:00:00 - 12:59:59 38366 2.8% 10.6614.1 GB 3.1%4096.87
Feb 9 13:00:00 - 13:59:59 44624 3.2% 12.4015.1 GB 3.4%4402.18
Feb 9 14:00:00 - 14:59:59 42527 3.1% 11.8114.1 GB 3.1%4110.59
Feb 9 15:00:00 - 15:59:59 48763 3.5% 13.5515.2 GB 3.4%4426.63
Feb 9 16:00:00 - 16:59:59 45847 3.3% 12.7414.3 GB 3.2%4166.58
Feb 9 17:00:00 - 17:59:59 42545 3.1% 11.8213.2 GB 2.9%3842.48
Feb 9 18:00:00 - 18:59:59 38488 2.8% 10.6911.6 GB 2.6%3379.55
Feb 9 19:00:00 - 19:59:59 55614 4.0% 15.4515.4 GB 3.4%4492.78
Feb 9 20:00:00 - 20:59:59 71496 5.2% 19.8617.1 GB 3.8%4982.23
Feb 9 21:00:00 - 21:59:59 40382 2.9% 11.2212.6 GB 2.8%3664.48
Feb 9 22:00:00 - 22:59:59 41362 3.0% 11.4912.9 GB 2.9%3765.65
Feb 9 23:00:00 - 23:59:59 45106 3.3% 12.5314.9 GB 3.3%4343.99
Feb 10 00:00:00 - 00:59:59 74696 5.4% 20.7523.1 GB 5.2%6741.82
Feb 10 01:00:00 - 01:59:59 87528 6.3% 24.3127.8 GB 6.2%8084.59
Feb 10 02:00:00 - 02:59:59 106859 7.7% 29.6833.8 GB 7.5%9845.63
Feb 10 03:00:00 - 03:59:59 85828 6.2% 23.8427.7 GB 6.2%8060.43
Feb 10 04:00:00 - 04:15:02 9514 0.7% 10.553.2 GB 0.7%3662.66
TOTAL: 23:59:59 1384208 100.0% 16.02449.4 GB 100.0%5453.87
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3476 280 0 2688 11 0 0 0 497
2news.task.gda.pl 1267 1065 0 59 0 0 0 0 143
3news.nask.pl 647 10 0 600 11 0 0 0 26
4news.icm.edu.pl 30 0 0 11 0 0 0 0 19
TOTAL: 4 5420 1355 0 3358 22 0 0 0 685

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 174
mailing.freebsd.svn-ports-head 171
uk.railway 108
mailing.freebsd.ports-bugs 86
alt.windows7.general 64
fr.usenet.abus.nocem 52
mailing.openbsd.source-changes 51
it.comp.os.win.windows7 48
fa.freebsd.cvs-all 45
mailing.freebsd.svn-src-all 44
mailing.freebsd.ports 39
mailing.openbsd.ports-changes 37
mailing.openbsd.misc 35
alt.politics.scorched-earth 34
mailing.unix.samba 30
mailing.freebsd.svn-src-head 28
it.tlc.cellulari.android 23
comp.mobile.android 21
mozilla.dev.tree-management 16
nl.comp.os.linux.techniek 16
TOTAL: 75 1355

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

GroupsCount
pl.sci.historia 18
pl.sci.matematyka 4
TOTAL: 2 22

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 338
EMP (fsl) 109
Attached HTML file 48
EMP (md5) 22
EMP (phl) 11
HTML post 4
Scoring filter (8) 3
Scoring filter (12) 1
Scoring filter (9) 1
TOTAL: 9 537

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 63244 14185 28759 5129 28 481 22%23:42:16
2panorama 49995 1851 46493 298 1 0 3%23:54:22
3task 1658 48 859 7 0 2 2%20:11:34
4poznan 12686 38 11253 16 1 0 0%23:54:15
5nask 24358 30 15344 1 0 26 0%23:42:15
6okapi 0 0 0 0 0 2334 0%23:46:44
TOTAL: 6 151941 16152 102708 5451 30 2843 10%139:11:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.4 GB775.3 MB2.2 GB27.1 KB/s119.7 KB23:42:16
2panorama8.4 MB1.4 MB9.7 MB0.1 KB/s4.6 KB23:54:22
3nask125.2 KB374.7 KB499.9 KB0.0 KB/s16.1 KB23:42:15
4poznan116.3 KB31.8 KB148.0 KB0.0 KB/s2.7 KB23:54:15
5task100.8 KB24.2 KB125.0 KB0.0 KB/s2.3 KB20:11:34
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:46:44
TOTAL: 61.5 GB777.1 MB2.2 GB4.6 KB/s107.5 KB139:11:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 281 279406.2 KB 279 0 000:00:11
2web.man.lodz.pl 293 9485.8 KB 42 0 000:00:38
3212.191.78.190 100 1525.3 KB 4 0 015:19:23
4ip-176.105.135.22.tvsat364.lodz.pl 6 13112.0 KB 3 0 001:23:45
TOTAL: 4 680 401629.4 KB 328 0 033:23:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 281 279406.2 KB 279 0 000:00:11
2*.man.lodz.pl 671 9485.8 KB 42 0 000:00:47
3unresolved 100 1525.3 KB 4 0 015:19:23
4*.105.135.22.tvsat364.lodz.pl 6 13112.0 KB 3 0 001:23:45
5*.pa.nsw.optusnet.com.au 96 00.0 KB 0 0 000:03:02
6*.207.15.62.static.jazztel.es 10 00.0 KB 0 0 016:34:24
7*.neoplus.adsl.tpnet.pl 1 00.0 KB 0 0 000:00:39
8*.lodz.mm.pl 1 00.0 KB 0 0 000:00:31
9*.toya.net.pl 37 00.0 KB 0 0 000:00:13
TOTAL: 91203 401629.4 KB 328 0 033:23:00

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
64.207.15.62.static.jazztel.es 174.724 259.976 0.00016:34:24
212.191.78.190 0.256 1.008 0.00015:19:23
ip-176.105.135.22.tvsat364.lodz.pl 0.016 0.064 0.00001:23:45
pa49-181-246-169.pa.nsw.optusnet.com.au 0.220 0.644 0.00000:03:02
ecg43.neoplus.adsl.tpnet.pl 0.000 0.012 0.00000:00:39
web.man.lodz.pl 0.640 2.568 0.00000:00:38
host-89-228-165-179.lodz.mm.pl 0.000 0.008 0.00000:00:31
staticline41435.toya.net.pl 0.084 0.288 0.00000:00:13
vegas.cm.p.lodz.pl 0.612 2.340 0.00000:00:11
mon.man.lodz.pl 0.656 2.308 0.00000:00:06
david.man.lodz.pl 0.196 0.772 0.00000:00:02
? 0.004 0.036 0.00000:00:00
TOTAL: 12 177.408 270.024 0.00033:23:00

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 285
pa49-181-246-169.pa.nsw.optusnet.com.au 96
david.man.lodz.pl 93
staticline41435.toya.net.pl 37
64.207.15.62.static.jazztel.es 10
host-89-228-165-179.lodz.mm.pl 1
ecg43.neoplus.adsl.tpnet.pl 1
TOTAL: 7 523

NNRP client timeouts [Top 20]:

SystemConnPeer
ip-176.105.135.22.tvsat364.lodz.pl 2 0
64.207.15.62.static.jazztel.es 1 0
TOTAL: 2 3 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 279 69.6%
2pl 122 30.4%
TOTAL: 2 401100.0%

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

NewsgroupCount
1lodman.info 279
2pl.comp.pecet 88
3pl.misc.kolej 14
4pl.soc.prawo 11
5pl.comp.os.ms-windows.winnt 6
6pl.soc.dzieci 1
7pl.rec.rowery 1
8pl.regionalne.lodz 1
TOTAL: 8 401