Daily Usenet report

Feb 8 04:15:04 -- Feb 9 04:15:03

Unknown entries from news log file:

First 22 / 22 lines (100.0%)

Feb 8 23:35:01 newsfeed nnrpd[13412]: load 64.00 > 16
Feb 8 23:35:01 newsfeed nnrpd[13411]: load 64.00 > 16
Feb 8 23:35:02 newsfeed nnrpd[13416]: load 64.00 > 16
Feb 8 23:35:02 newsfeed nnrpd[13418]: load 64.00 > 16
Feb 8 23:35:02 newsfeed nnrpd[13419]: load 64.00 > 16
Feb 8 23:35:02 newsfeed nnrpd[13420]: load 64.00 > 16
Feb 8 23:35:02 newsfeed nnrpd[13421]: load 64.00 > 16
Feb 8 23:35:02 newsfeed nnrpd[13422]: load 64.00 > 16
Feb 8 23:35:03 newsfeed nnrpd[13423]: load 64.00 > 16
Feb 8 23:35:03 newsfeed nnrpd[13424]: load 64.00 > 16
Feb 8 23:35:03 newsfeed nnrpd[13425]: load 64.00 > 16
Feb 8 23:35:03 newsfeed nnrpd[13426]: load 64.00 > 16
Feb 8 23:35:03 newsfeed nnrpd[13427]: load 64.00 > 16
Feb 8 23:35:03 newsfeed nnrpd[13428]: load 64.00 > 16
Feb 8 23:35:03 newsfeed nnrpd[13429]: load 64.00 > 16
Feb 8 23:35:29 newsfeed nnrpd[13449]: load 39.13 > 16
Feb 8 23:35:29 newsfeed nnrpd[13450]: load 39.13 > 16
Feb 8 23:35:48 newsfeed nnrpd[13475]: load 30.68 > 16
Feb 9 00:24:17 newsfeed innfeed[2186]: task:0 connect: Network is unreachable
Feb 9 00:24:17 newsfeed innfeed[2186]: nask:0 connect: Network is unreachable
Feb 9 00:24:17 newsfeed innfeed[2186]: icm:0 connect: Network is unreachable
Feb 9 00:1Feb 9 00:21:39.642 + news.task.gda.pl <ld6f00$r49$1@mx1.internetia.pl> 2350 INFLOW overview! poznan okapi panorama icm

Log entries by program:

Program nameLines%LinesSize%Size
inn1152776 97.5%131.4 MB 97.0%
innd 12780 1.1%2.1 MB 1.6%
nnrpd 10281 0.9%1.0 MB 0.8%
innfeed 6868 0.6%1020.5 KB 0.7%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 51182706 100.0%135.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1147629 89.8%
Negative hits 91437 7.2%
Positive hits 37949 3.0%
Cache misses 481 0.0%
TOTAL: 4 1277496 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:10.311 0.0%425 0.000 24.261 362.000
article cleanup00:00:18.596 0.0%1151167 0.000 0.016 0.039
article logging00:00:38.079 0.0%1151301 0.000 0.033 0.406
article parse00:44:50.320 3.1%110667323 0.010 0.024 0.087
article write00:13:42.821 1.0%1145766 0.321 0.718 14.072
artlog/artcncl00:00:00.009 0.0%417 0.000 0.022 1.000
artlog/artparse00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:02:22.575 0.2%118066590 0.001 0.001 0.008
hisgrep/artcncl00:00:01.811 0.0%322 0.000 5.624 101.000
hishave/artcncl00:00:02.168 0.0%425 0.000 5.101 260.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup04:16:00.826 17.8%1277283 0.048 12.026 181.760
history sync00:00:03.012 0.0%285 0.000 10.568 3004.000
history write05:03:35.120 21.1%1147335 5.222 15.876 3291.662
hiswrite/artcncl00:00:01.477 0.0%103 0.000 14.340 284.000
idle09:14:51.456 38.6%84055770 0.152 0.396 60023.000
nntp read00:43:27.086 3.0%109795166 0.013 0.024 0.046
overview write00:00:07.521 0.0%1145766 0.000 0.007 0.017
perl filter02:51:14.297 11.9%1147331 3.646 8.955 96.500
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:02:25.802 0.2%2342403 0.008 0.062 0.400
TOTAL: 23:57:00.61123:13:53.287 97.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.192 0.0%54200 0.000 0.004 0.091
article prepare00:00:00.024 0.0%72732 0.000 0.000 0.083
article read00:00:04.197 0.0%18034 0.000 0.233 21.600
backlog stats00:00:00.328 0.0%380746 0.000 0.001 0.018
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.636 0.0%213474 0.000 0.012 1.000
data write00:00:13.080 0.0%205981 0.000 0.064 7.000
idle23:25:00.555 97.8%380746 0.000 221.409 30100.000
status file00:31:29.329 2.2%289 0.000 6537.4711658130.000
TOTAL: 23:57:01.29623:56:50.341100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.070 0.0%8 8.750 8.750 8.750
idle57:14:59.301100.0%30512 0.000 6754.697156785.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:21.171 0.0%63014 0.000 0.336 107.500
readart00:00:13.808 0.0%389 0.000 35.496 2145.400
TOTAL: 57:16:17.39957:15:34.350100.0%----

Control commands to INND:

CommandNumber
L 1
flush 23
flushlogs 2
go 2
logmode 2
mode 147
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 188

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 836 11367961132097 1012 3687 99%366:22:34
2news.task.gda.pl 21 29544 8569 19868 1107 29%43:48:17
3news.nask.pl 5 16933 4243 12150 540 25%23:18:51
4news.icm.edu.pl 40 265 24 219 22 9%18:10:37
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 903 11835381144933 33249 5356 96%451:40:19
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl382.9 GB26.2 MB58.1 MB383.0 GB 99%353.6 KB
2news.nask.pl19.3 MB2.0 MB2.0 MB23.3 MB 82%5.0 KB
3news.task.gda.pl17.5 MB142.1 KB2.9 MB20.6 MB 85%2.2 KB
4news.icm.edu.pl1.2 MB825.5 KB1.2 MB3.2 MB 36%71.0 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 5383.0 GB29.1 MB64.3 MB383.0 GB 99%349.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 8 04:15:04 - 04:59:59 55531 4.8% 20.6018.7 GB 4.9%7285.38
Feb 8 05:00:00 - 05:59:59 34819 3.0% 9.6713.3 GB 3.5%3869.87
Feb 8 06:00:00 - 06:59:59 28352 2.5% 7.8811.3 GB 3.0%3304.94
Feb 8 07:00:00 - 07:59:59 32087 2.8% 8.9112.4 GB 3.2%3610.09
Feb 8 08:00:00 - 08:59:59 34526 3.0% 9.5913.1 GB 3.4%3820.46
Feb 8 09:00:00 - 09:59:59 54433 4.7% 15.1215.5 GB 4.0%4509.48
Feb 8 10:00:00 - 10:59:59 64537 5.6% 17.9316.1 GB 4.2%4700.05
Feb 8 11:00:00 - 11:59:59 39654 3.5% 11.0214.0 GB 3.7%4085.45
Feb 8 12:00:00 - 12:59:59 40075 3.5% 11.1315.0 GB 3.9%4371.69
Feb 8 13:00:00 - 13:59:59 42598 3.7% 11.8314.9 GB 3.9%4346.36
Feb 8 14:00:00 - 14:59:59 46109 4.0% 12.8114.5 GB 3.8%4227.90
Feb 8 15:00:00 - 15:59:59 47124 4.1% 13.0915.7 GB 4.1%4571.94
Feb 8 16:00:00 - 16:59:59 44211 3.9% 12.2815.3 GB 4.0%4444.17
Feb 8 17:00:00 - 17:59:59 42963 3.7% 11.9314.9 GB 3.9%4342.65
Feb 8 18:00:00 - 18:59:59 40071 3.5% 11.1313.3 GB 3.5%3861.20
Feb 8 19:00:00 - 19:59:59 38886 3.4% 10.8013.5 GB 3.5%3918.78
Feb 8 20:00:00 - 20:59:59 38231 3.3% 10.6213.1 GB 3.4%3803.01
Feb 8 21:00:00 - 21:59:59 38617 3.4% 10.7313.0 GB 3.4%3789.04
Feb 8 22:00:00 - 22:59:59 41578 3.6% 11.5514.6 GB 3.8%4244.30
Feb 8 23:00:00 - 23:59:59 17196 1.5% 4.785.8 GB 1.5%1699.69
Feb 9 00:00:00 - 00:59:59 66127 5.8% 18.3721.4 GB 5.6%6247.17
Feb 9 01:00:00 - 01:59:59 80652 7.0% 22.4026.4 GB 6.9%7702.65
Feb 9 02:00:00 - 02:59:59 79002 6.9% 21.9525.2 GB 6.6%7349.81
Feb 9 03:00:00 - 03:59:59 82342 7.2% 22.8726.4 GB 6.9%7697.79
Feb 9 04:00:00 - 04:15:03 17099 1.5% 18.945.6 GB 1.5%6549.88
TOTAL: 23:59:59 1146820 100.0% 13.27383.2 GB 100.0%4650.78
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3801 177 0 3242 3 0 0 0 379
2news.task.gda.pl 1140 806 0 58 2 0 0 0 274
3news.nask.pl 576 9 0 524 3 0 0 0 40
4news.icm.edu.pl 22 0 0 12 0 0 0 0 10
TOTAL: 4 5539 992 0 3836 8 0 0 0 703

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-head 119
mailing.freebsd.svn-ports-all 118
uk.railway 93
fr.usenet.abus.nocem 71
mailing.openbsd.ports-changes 44
mailing.freebsd.ports-bugs 42
mailing.freebsd.ports 40
fa.freebsd.cvs-all 32
mailing.freebsd.svn-src-all 30
mailing.openbsd.source-changes 27
24hoursupport.helpdesk 24
it.comp.os.win.windows8 23
alt.windows7.general 23
mailing.unix.samba 20
mailing.freebsd.svn-src-head 18
mailing.dragonflybsd.commits 17
mailing.database.pgsql-general 17
it.comp.os.win.windows7 16
comp.mobile.ipad 15
alt.politics.scorched-earth 15
TOTAL: 64 992

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

GroupsCount
pl.sci.historia 5
pl.sci.matematyka 2
fr.comp.lang.php 1
TOTAL: 3 8

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 251
EMP (fsl) 142
EMP (phl) 109
EMP (md5) 34
Attached HTML file 24
Scoring filter (10) 2
HTML post 2
Scoring filter (8) 1
TOTAL: 8 565

INND misc events:

EventsCount
CCreader 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 66304 3825 33703 12854 4 1218 5%23:52:38
2panorama 51352 1186 49232 210 0 1057 2%23:51:36
3poznan 13218 17 12278 8 0 659 0%23:53:03
4task 2077 16 1142 5 0 8 0%22:26:38
5nask 21115 6 14864 3 0 393 0%23:46:54
6okapi 0 0 0 0 0 2361 0%23:50:07
TOTAL: 6 154066 5050 111219 13080 4 5696 3%141:40:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm381.8 MB3.2 GB3.5 GB43.3 KB/s223.0 KB23:52:38
2panorama6.2 MB2.7 MB8.9 MB0.1 KB/s6.5 KB23:51:36
3poznan60.3 KB12.8 KB73.1 KB0.0 KB/s2.9 KB23:53:03
4nask52.2 KB11.7 KB63.8 KB0.0 KB/s7.1 KB23:46:54
5task32.0 KB7.4 KB39.3 KB0.0 KB/s1.9 KB22:26:38
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:07
TOTAL: 6388.1 MB3.2 GB3.6 GB7.3 KB/s205.7 KB141:40:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 280 280407.7 KB 280 0 000:00:13
2web.man.lodz.pl 280 8275.9 KB 33 0 000:00:21
3212.191.78.190 289 2135.8 KB 10 0 045:49:58
45.174.16.142 14 33.2 KB 3 0 000:00:13
TOTAL: 4 863 386522.6 KB 326 0 057:16:16

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 280 280407.7 KB 280 0 000:00:13
2*.man.lodz.pl 674 8275.9 KB 33 0 000:00:29
3unresolved 303 2439.0 KB 13 0 045:50:11
4*.pa.nsw.optusnet.com.au 102 00.0 KB 0 0 000:03:04
5*.191.14.62.static.jazztel.es 12 00.0 KB 0 0 005:01:25
6*.207.15.62.static.jazztel.es 21 00.0 KB 0 0 006:20:50
7*.toya.net.pl 2 00.0 KB 0 0 000:00:00
TOTAL: 71394 386522.6 KB 326 0 057:16:16

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.716 4.148 0.00045:49:58
64.207.15.62.static.jazztel.es 19.620 22.220 0.00006:03:20
216.191.14.62.static.jazztel.es 0.600 0.924 0.00005:01:25
202.207.15.62.static.jazztel.es 0.004 0.072 0.00000:17:29
pa49-181-246-247.pa.nsw.optusnet.com.au 0.260 1.448 0.00000:03:04
web.man.lodz.pl 0.684 4.168 0.00000:00:21
vegas.cm.p.lodz.pl 0.548 5.140 0.00000:00:13
5.174.16.142 0.120 0.372 0.00000:00:13
mon.man.lodz.pl 0.648 4.460 0.00000:00:06
david.man.lodz.pl 0.252 1.404 0.00000:00:02
staticline41435.toya.net.pl 0.004 0.036 0.00000:00:00
? 0.028 0.188 0.00000:00:00
TOTAL: 12 23.484 44.580 0.00057:16:16

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 300
pa49-181-246-247.pa.nsw.optusnet.com.au 102
david.man.lodz.pl 94
64.207.15.62.static.jazztel.es 17
216.191.14.62.static.jazztel.es 12
202.207.15.62.static.jazztel.es 4
staticline41435.toya.net.pl 2
TOTAL: 7 531

NNRP client timeouts [Top 20]:

SystemConnPeer
216.191.14.62.static.jazztel.es 5 0
64.207.15.62.static.jazztel.es 3 1
202.207.15.62.static.jazztel.es 1 0
TOTAL: 3 9 1

Newsgroup request counts (by category):

CategoryCountPct
1lodman 281 72.8%
2pl 103 26.7%
3lodz 2 0.5%
TOTAL: 3 386100.0%

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

NewsgroupCount
1lodman.info 281
2pl.comp.pecet 80
3pl.misc.kolej 8
4pl.soc.prawo 5
5pl.rec.rowery 4
6pl.regionalne.warszawa 2
7pl.comp.os.ms-windows.winnt 2
8lodz.test 2
9pl.praca.dyskusje 1
10pl.rec.gory 1
TOTAL: 10 386