Daily Usenet report

Dec 29 04:15:03 -- Dec 30 04:15:02

Unknown entries from news log file:

First 31 / 31 lines (100.0%)

Dec 29 21:39:51 newsfeed nnrpd[29500]: load 39.00 > 16
Dec 29 21:39:51 newsfeed nnrpd[29579]: load 39.00 > 16
Dec 29 21:39:51 newsfeed nnrpd[29580]: load 39.00 > 16
Dec 29 21:39:51 newsfeed nnrpd[29581]: load 39.00 > 16
Dec 29 21:39:55 newsfeed nnrpd[29598]: load 36.60 > 16
Dec 29 21:39:55 newsfeed nnrpd[29600]: load 36.60 > 16
Dec 29 21:39:55 newsfeed nnrpd[29601]: load 36.60 > 16
Dec 29 21:39:55 newsfeed nnrpd[29599]: load 36.60 > 16
Dec 29 21:40:49 newsfeed nnrpd[29607]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:40:49 newsfeed nnrpd[29608]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:40:49 newsfeed nnrpd[29609]: vegas.cm.p.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:40:49 newsfeed nnrpd[29610]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:40:49 newsfeed nnrpd[29611]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:40:49 newsfeed nnrpd[29612]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:40:49 newsfeed nnrpd[29613]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:40:49 newsfeed nnrpd[29614]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:41:00 newsfeed nnrpd[29615]: mon.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:41:48 newsfeed nnrpd[29616]: staticline41435.toya.net.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:43:28 newsfeed nnrpd[29657]: david.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:45:48 newsfeed nnrpd[29662]: vegas.cm.p.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:45:48 newsfeed nnrpd[29663]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:45:48 newsfeed nnrpd[29664]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:45:48 newsfeed nnrpd[29665]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:45:49 newsfeed nnrpd[29666]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:45:49 newsfeed nnrpd[29667]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:45:49 newsfeed nnrpd[29668]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:45:49 newsfeed nnrpd[29669]: web.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:46:00 newsfeed nnrpd[29670]: mon.man.lodz.pl rejected loadav [innwatch:hiload] 3900 gt 2000
Dec 29 21:54:37 newsfeed innfeed[2175]: task:0 connect: Network is unreachable
Dec 29 21:54:37 newsfeed innfeed[2175]: nask:0 connect: Network is unreachable
Dec 29 21:54:37 newsfeed innfeed[2175]: icm:0 connect: Network is unreachable

Log entries by program:

Program nameLines%LinesSize%Size
inn1574572 98.6%183.7 MB 98.2%
innd 12168 0.8%2.1 MB 1.1%
nnrpd 5552 0.3%569.3 KB 0.3%
innfeed 5245 0.3%799.7 KB 0.4%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 51597538 100.0%187.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1570059 96.4%
Negative hits 33695 2.1%
Positive hits 17682 1.1%
Cache misses 6648 0.4%
TOTAL: 4 1628084 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:08.551 0.0%331 0.000 25.834 403.000
article cleanup00:00:24.523 0.0%1573088 0.000 0.016 0.026
article logging00:00:45.254 0.1%1573180 0.000 0.029 0.356
article parse00:52:36.055 3.7%122416588 0.009 0.026 0.095
article write00:13:02.911 0.9%1568645 0.000 0.499 5.900
artlog/artcncl00:00:00.008 0.0%327 0.000 0.024 1.000
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:02:37.510 0.2%132180834 0.000 0.001 0.005
hisgrep/artcncl00:00:00.470 0.0%185 0.000 2.541 112.000
hishave/artcncl00:00:00.757 0.0%331 0.000 2.287 14.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:10:00.352 9.0%1628094 0.148 4.791 24.902
history sync00:00:00.005 0.0%221 0.000 0.023 1.000
history write09:30:38.246 39.7%1570114 0.380 21.806 15589.241
hiswrite/artcncl00:00:01.071 0.0%146 0.000 7.336 81.333
idle06:21:06.420 26.5%73571620 0.023 0.311 60061.000
nntp read00:47:04.256 3.3%121214762 0.000 0.023 0.044
overview write00:00:09.580 0.0%1568645 0.000 0.006 0.015
perl filter03:33:40.037 14.9%1570110 1.833 8.165 1819.000
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:06.380 0.2%3171679 0.000 0.059 0.082
TOTAL: 23:57:13.18323:35:22.386 98.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.119 0.0%38551 0.000 0.003 0.143
article prepare00:00:00.020 0.0%40952 0.000 0.000 0.083
article read00:00:01.140 0.0%9834 0.000 0.116 1.053
backlog stats00:00:00.160 0.0%231047 0.000 0.001 1.000
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.620 0.0%140497 0.000 0.012 0.081
data write00:00:05.586 0.0%119764 0.000 0.047 1.579
idle17:39:21.528 73.6%231047 0.000 275.102 30101.000
status file06:18:51.663 26.3%239 0.000 95111.56122730573.000
TOTAL: 23:58:26.84423:58:21.836100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.108 0.0%32 3.375 3.375 3.375
idle09:27:37.564 99.4%20416 0.000 1668.180600117.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.723 0.0%42131 0.000 0.017 0.889
readart00:00:03.194 0.0%264 0.000 12.098 325.000
TOTAL: 09:30:57.35509:27:41.589 99.4%----

Control commands to INND:

CommandNumber
L 1
flush 18
flushlogs 2
go 3
logmode 2
mode 112
name 2
pause 2
paused 2
reload 2
reserve 2
throttle 2
TOTAL: 12 150

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 285 15548071551751 118 2938 99%272:23:05
2news.task.gda.pl 18 25940 14019 10796 1125 54%44:33:10
3news.nask.pl 6 14642 3794 10446 402 25%21:36:57
4news.icm.edu.pl 34 250 29 198 23 11%17:48:43
5localhost 1 0 0 0 0 0%00:00:02
TOTAL: 5 344 15956391569593 21558 4488 98%356:21:57
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl485.8 GB37.9 MB62.0 MB485.9 GB 99%327.7 KB
2news.task.gda.pl30.7 MB209.9 KB2.9 MB33.8 MB 90%2.3 KB
3news.nask.pl17.7 MB1.1 MB1.2 MB20.0 MB 88%4.9 KB
4news.icm.edu.pl1.6 MB184.7 KB836.0 KB2.6 MB 61%50.6 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 5485.9 GB39.4 MB66.9 MB486.0 GB 99%323.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 29 04:15:03 - 04:59:59 69629 4.4% 25.8223.4 GB 0.0%9096.64
Dec 29 05:00:00 - 05:59:59 94154 6.0% 26.1530.5 GB 0.0%8877.84
Dec 29 06:00:00 - 06:59:59 99609 6.3% 27.6731.6 GB 0.0%9206.30
Dec 29 07:00:00 - 07:59:59 102967 6.6% 28.6032.3 GB 0.0%9413.96
Dec 29 08:00:00 - 08:59:59 87165 5.6% 24.2127.3 GB 0.0%7940.43
Dec 29 09:00:00 - 09:59:59 83763 5.3% 23.2726.1 GB 17.9%7592.28
Dec 29 10:00:00 - 10:59:59 83286 5.3% 23.1425.9 GB 17.8%7535.69
Dec 29 11:00:00 - 11:59:59 78605 5.0% 21.8324.5 GB 16.9%7144.99
Dec 29 12:00:00 - 12:59:59 94572 6.0% 26.2730.7 GB 21.1%8928.95
Dec 29 13:00:00 - 13:59:59 101355 6.5% 28.1532.0 GB 22.0%9329.98
Dec 29 14:00:00 - 14:59:59 104127 6.6% 28.9231.6 GB 21.7%9199.15
Dec 29 15:00:00 - 15:59:59 21806 1.4% 6.066.9 GB 4.7%2000.97
Dec 29 16:00:00 - 16:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Dec 29 17:00:00 - 17:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Dec 29 18:00:00 - 18:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Dec 29 19:00:00 - 19:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Dec 29 20:00:00 - 20:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Dec 29 21:00:00 - 21:59:59 4075 0.3% 1.13407.1 MB 0.3% 115.80
Dec 29 22:00:00 - 22:59:59 89562 5.7% 24.8825.1 GB 17.3%7321.57
Dec 29 23:00:00 - 23:59:59 84128 5.4% 23.3724.4 GB 16.8%7113.61
Dec 30 00:00:00 - 00:59:59 78025 5.0% 21.6723.0 GB 15.8%6696.57
Dec 30 01:00:00 - 01:59:59 81944 5.2% 22.7624.2 GB 16.6%7042.20
Dec 30 02:00:00 - 02:59:59 101587 6.5% 28.2232.7 GB 22.5%9510.62
Dec 30 03:00:00 - 03:59:59 87998 5.6% 24.4426.9 GB 18.5%7833.27
Dec 30 04:00:00 - 04:15:02 21348 1.4% 23.676.7 GB 4.6%7806.64
TOTAL: 23:59:59 1569705 100.0% 18.17145.3 GB 100.0%1763.99
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 2975 125 0 2533 0 0 0 0 317
2news.task.gda.pl 1142 820 0 94 3 0 0 0 225
3news.nask.pl 399 16 0 348 0 0 0 0 35
4news.icm.edu.pl 24 0 0 4 0 0 0 0 20
TOTAL: 4 4540 961 0 2979 3 0 0 0 597

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 132
mailing.freebsd.svn-ports-all 126
mailing.freebsd.svn-ports-head 124
fr.usenet.abus.nocem 51
mailing.freebsd.svn-src-all 49
fa.freebsd.cvs-all 46
mailing.freebsd.ports-bugs 45
mailing.freebsd.svn-src-head 42
24hoursupport.helpdesk 36
alt.politics.scorched-earth 28
mailing.openbsd.ports-changes 25
mailing.openbsd.source-changes 23
comp.mobile.android 20
mailing.openbsd.misc 15
it.tlc.cellulari.android 14
it.comp.os.win.windows7 10
mailing.dragonflybsd.commits 10
mailing.postfix.users 10
comp.mobile.ipad 10
mailing.freebsd.ports 9
TOTAL: 67 961

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

GroupsCount
pl.sci.historia 2
fr.comp.applications.libres 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 230
EMP (fsl) 171
Attached HTML file 68
EMP (md5) 26
EMP (phl) 3
HTML post 2
Scoring filter (9) 1
TOTAL: 7 501

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 42531 7079 25491 1522 6 4143 16%23:54:59
2panorama 35224 1228 32833 293 0 0 3%23:51:43
3poznan 17527 41 16336 26 0 0 0%23:57:14
4task 808 4 446 1 0 5 0%20:24:24
5nask 11990 4 9193 34 0 0 0%23:51:59
6okapi 0 0 0 0 0 1711 0%23:58:50
TOTAL: 6 108080 8356 84299 1876 6 5859 7%139:59:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm806.2 MB345.5 MB1.1 GB13.7 KB/s137.1 KB23:54:59
2panorama3.8 MB1.7 MB5.5 MB0.1 KB/s3.7 KB23:51:43
3poznan94.8 KB41.0 KB135.8 KB0.0 KB/s2.0 KB23:57:14
4task12.4 KB1.6 KB14.0 KB0.0 KB/s2.8 KB20:24:24
5nask7.3 KB38.6 MB38.6 MB0.5 KB/s1.0 MB23:51:59
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:50
TOTAL: 6810.1 MB385.9 MB1.2 GB2.4 KB/s119.7 KB139:59:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 210 207260.0 KB 207 0 000:01:40
2web.man.lodz.pl 222 4845.0 KB 11 0 000:01:43
3ebo45.neoplus.adsl.tpnet.pl 1 811.4 KB 1 0 000:16:55
TOTAL: 3 433 263316.3 KB 219 0 009:30:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 210 207260.0 KB 207 0 000:01:40
2*.man.lodz.pl 503 4845.0 KB 11 0 000:01:49
3*.neoplus.adsl.tpnet.pl 4 811.4 KB 1 0 001:18:28
4*.as13285.net 1 00.0 KB 0 0 000:00:40
5*.207.15.62.static.jazztel.es 2 00.0 KB 0 0 001:41:11
6unresolved 40 00.0 KB 0 0 006:27:05
7*.toya.net.pl 30 00.0 KB 0 0 000:00:01
TOTAL: 7 790 263316.3 KB 219 0 009:30:56

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.092 0.612 0.00006:27:05
158.207.15.62.static.jazztel.es 0.936 1.356 0.00001:41:11
ebr225.neoplus.adsl.tpnet.pl 0.008 0.056 0.00001:01:33
ebo45.neoplus.adsl.tpnet.pl 0.000 0.016 0.00000:16:55
web.man.lodz.pl 0.460 3.248 0.00000:01:43
vegas.cm.p.lodz.pl 0.444 3.216 0.00000:01:40
host-92-25-6-175.as13285.net 0.040 0.000 0.00000:00:40
mon.man.lodz.pl 0.472 2.964 0.00000:00:03
staticline41435.toya.net.pl 0.064 0.240 0.00000:00:01
david.man.lodz.pl 0.140 0.960 0.00000:00:01
? 0.012 0.116 0.00000:00:00
TOTAL: 11 2.668 12.784 0.00009:30:56

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 210
david.man.lodz.pl 71
212.191.78.190 40
staticline41435.toya.net.pl 30
ebr225.neoplus.adsl.tpnet.pl 3
158.207.15.62.static.jazztel.es 2
host-92-25-6-175.as13285.net 1
TOTAL: 7 357

NNRP client timeouts [Top 20]:

SystemConnPeer
ebr225.neoplus.adsl.tpnet.pl 2 0
158.207.15.62.static.jazztel.es 1 1
TOTAL: 2 3 1

Newsgroup request counts (by category):

CategoryCountPct
1lodman 215 81.7%
2pl 48 18.3%
TOTAL: 2 263100.0%

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

NewsgroupCount
1lodman.info 215
2pl.comp.pecet 26
3pl.comp.os.ms-windows.winnt 22
TOTAL: 3 263