Daily Usenet report

Jan 27 04:15:03 -- Jan 28 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Jan 27 05:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 27 07:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 27 07:36:02 newsfeed nnrpd[9996]: SERVER perl filter not defined
Jan 27 09:22:36 newsfeed nnrpd[13535]: SERVER perl filter not defined
Jan 27 09:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 27 11:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 27 12:11:32 newsfeed nnrpd[18944]: SERVER perl filter not defined
Jan 27 13:17:26 newsfeed nnrpd[21155]: SERVER perl filter not defined
Jan 27 13:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 27 15:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 27 16:21:03 newsfeed nnrpd[27206]: SERVER perl filter not defined
Jan 27 17:34:10 newsfeed nnrpd[29668]: SERVER perl filter not defined
Jan 27 17:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 27 18:08:18 newsfeed nnrpd[30660]: SERVER perl filter not defined
Jan 27 19:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable
Jan 27 21:36:02 newsfeed innfeed[2229]: icm:0 connect: Network is unreachable

Log entries by program:

Program nameLines%LinesSize%Size
inn1700945 98.1%194.7 MB 97.6%
innd 15485 0.9%2.5 MB 1.3%
nnrpd 10911 0.6%1.1 MB 0.6%
innfeed 7091 0.4%1.1 MB 0.5%
TOTAL: 41734432 100.0%199.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1694352 93.5%
Negative hits 68657 3.8%
Positive hits 44604 2.5%
Cache misses 4244 0.2%
TOTAL: 4 1811857 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:12.186 0.0%364 0.000 33.478 667.000
article cleanup00:00:26.884 0.0%1699943 0.006 0.016 0.032
article logging00:00:53.130 0.1%1700071 0.012 0.031 0.427
article parse01:06:17.791 4.6%160457414 0.010 0.025 0.076
article write00:15:46.860 1.1%1692683 0.270 0.559 1.827
artlog/artcncl00:00:00.012 0.0%357 0.000 0.034 1.000
artlog/artparse00:00:00.000 0.0%5 0.000 0.000 0.000
data move00:02:45.060 0.2%171523670 0.001 0.001 0.003
hisgrep/artcncl00:00:01.344 0.0%302 0.000 4.450 196.000
hishave/artcncl00:00:00.656 0.0%364 0.000 1.802 192.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:50:24.226 7.7%1812581 0.964 3.655 28.483
history sync00:00:00.014 0.0%290 0.000 0.048 1.000
history write02:31:10.523 10.5%1695288 3.237 5.350 34.630
hiswrite/artcncl00:00:00.393 0.0%62 0.000 6.339 192.000
idle11:56:17.264 49.8%115743435 0.220 0.371 1.145
nntp read01:04:16.258 4.5%159207546 0.014 0.024 0.051
overview write00:00:11.132 0.0%1692683 0.000 0.007 0.023
perl filter04:14:55.161 17.7%1695283 5.854 9.022 12.267
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:42.598 0.3%3430550 0.009 0.065 0.101
TOTAL: 23:59:43.69923:07:21.492 96.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.233 0.0%68467 0.000 0.003 1.000
article prepare00:00:00.009 0.0%41378 0.000 0.000 0.062
article read00:00:56.726 0.1%10219 0.000 5.551 157.000
backlog stats00:00:00.238 0.0%293821 0.000 0.001 0.019
callbacks00:00:00.000 0.0%28 0.000 0.000 0.000
data read00:00:01.926 0.0%165562 0.000 0.012 0.086
data write00:00:08.610 0.0%142182 0.000 0.061 1.000
idle23:58:31.951 99.9%293821 0.000 293.757 9936.000
status file00:00:00.702 0.0%239 0.000 2.937 56.000
TOTAL: 23:59:49.53623:59:40.395100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.113 0.0%16 7.062 7.062 7.062
idle74:28:22.006100.0%61348 0.000 4370.183229116.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.322 0.0%125624 0.000 0.018 1.095
readart00:00:05.241 0.0%787 0.000 6.659 285.000
TOTAL: 74:29:22.34874:28:29.682100.0%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 631 16866331678333 3586 4714 99%248:32:14
2news.nask.pl 2 20336 7542 11658 1136 37%24:35:48
3news.task.gda.pl 10 32899 7072 24470 1357 21%45:14:21
4news.icm.edu.pl 5 4124 51 4013 60 1%06:48:14
5localhost 8 7 7 0 0 100%00:00:00
TOTAL: 5 656 17439991693005 43727 7267 97%325:10:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl548.5 GB107.5 MB225.1 MB548.8 GB 99%341.9 KB
2news.nask.pl36.5 MB3.1 MB3.2 MB42.8 MB 85%5.1 KB
3news.task.gda.pl14.5 MB42.4 KB4.0 MB18.6 MB 78%2.3 KB
4news.icm.edu.pl822.3 KB0.0 KB731.2 KB1.5 MB 52%14.0 KB
5localhost10.2 KB0.0 KB0.0 KB10.2 KB100%1.5 KB
TOTAL: 5548.6 GB110.7 MB233.1 MB548.9 GB 99%338.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 27 04:15:03 - 04:59:59 53162 3.1% 19.7118.6 GB 3.4%7233.35
Jan 27 05:00:00 - 05:59:59 60244 3.6% 16.7322.3 GB 4.1%6490.71
Jan 27 06:00:00 - 06:59:59 75253 4.4% 20.9026.5 GB 4.8%7704.27
Jan 27 07:00:00 - 07:59:59 82141 4.9% 22.8230.1 GB 5.5%8777.06
Jan 27 08:00:00 - 08:59:59 85886 5.1% 23.8631.9 GB 5.8%9278.87
Jan 27 09:00:00 - 09:59:59 78299 4.6% 21.7530.6 GB 5.6%8901.75
Jan 27 10:00:00 - 10:59:59 74640 4.4% 20.7330.1 GB 5.5%8767.98
Jan 27 11:00:00 - 11:59:59 79663 4.7% 22.1330.9 GB 5.6%8988.64
Jan 27 12:00:00 - 12:59:59 98784 5.8% 27.4428.8 GB 5.3%8401.84
Jan 27 13:00:00 - 13:59:59 95334 5.6% 26.4821.8 GB 4.0%6343.60
Jan 27 14:00:00 - 14:59:59 119465 7.1% 33.1827.6 GB 5.0%8036.28
Jan 27 15:00:00 - 15:59:59 86381 5.1% 23.9920.0 GB 3.6%5828.75
Jan 27 16:00:00 - 16:59:59 69485 4.1% 19.3021.6 GB 3.9%6280.10
Jan 27 17:00:00 - 17:59:59 36408 2.2% 10.1112.7 GB 2.3%3701.92
Jan 27 18:00:00 - 18:59:59 38156 2.3% 10.6013.1 GB 2.4%3817.01
Jan 27 19:00:00 - 19:59:59 42386 2.5% 11.7714.2 GB 2.6%4143.00
Jan 27 20:00:00 - 20:59:59 47228 2.8% 13.1215.6 GB 2.8%4539.50
Jan 27 21:00:00 - 21:59:59 40955 2.4% 11.3813.2 GB 2.4%3830.59
Jan 27 22:00:00 - 22:59:59 36846 2.2% 10.2313.2 GB 2.4%3843.46
Jan 27 23:00:00 - 23:59:59 49152 2.9% 13.6517.6 GB 3.2%5125.08
Jan 28 00:00:00 - 00:59:59 79360 4.7% 22.0424.9 GB 4.5%7262.41
Jan 28 01:00:00 - 01:59:59 73924 4.4% 20.5323.9 GB 4.4%6959.75
Jan 28 02:00:00 - 02:59:59 77732 4.6% 21.5925.3 GB 4.6%7372.98
Jan 28 03:00:00 - 03:59:59 88945 5.3% 24.7127.4 GB 5.0%7968.42
Jan 28 04:00:00 - 04:15:02 23367 1.4% 25.917.2 GB 1.3%8383.92
TOTAL: 23:59:59 1693196 100.0% 19.60548.9 GB 100.0%6661.89
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4813 223 0 3547 3 0 0 0 1040
2news.task.gda.pl 1372 1136 0 27 0 0 0 0 209
3news.nask.pl 1147 8 0 1086 7 0 0 0 46
4news.icm.edu.pl 60 0 0 0 0 0 0 0 60
TOTAL: 4 7392 1367 0 4660 10 0 0 0 1355

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 193
mailing.freebsd.svn-ports-head 188
uk.railway 94
mailing.freebsd.ports-bugs 74
mailing.freebsd.ports 49
mailing.unix.samba 45
24hoursupport.helpdesk 44
alt.politics.scorched-earth 43
gmane.linux.alsa.devel 38
mailing.gcc.gcc-cvs 36
alt.windows7.general 32
hr.alt.cellular.gsm.android 28
mailing.database.pgsql-general 28
comp.mobile.ipad 22
mailing.openbsd.source-changes 21
it.comp.os.win.windows7 19
mailing.freebsd.kde 19
mailing.postfix.users 18
it.comp.os.win.windows8 17
mailing.openbsd.ports-changes 17
TOTAL: 85 1367

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

GroupsCount
pl.sci.historia 9
soc.culture.jewish.holocaust 1
TOTAL: 2 10

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 792
Attached HTML file 173
EMP (fsl) 150
EMP (md5) 61
EMP (phl) 17
HTML post 8
Scoring filter (8) 8
Scoring filter (9) 7
Scoring filter (12) 5
Too many newsgroups 1
TOTAL: 10 1222

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 47040 3604 40867 597 0 0 7%23:51:28
2icm 32522 2362 25655 3457 77 35915 7%23:53:24
3poznan 17822 119 14280 51 0 0 0%24:02:32
4nask 22435 15 14304 0 0 0 0%24:00:27
5task 2758 9 1493 5 0 0 0%21:48:45
6okapi 0 0 0 0 0 3068 0%24:00:04
TOTAL: 6 122577 6109 96599 4110 77 38983 4%141:36:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm288.7 MB757.9 MB1.0 GB12.5 KB/s184.2 KB23:53:24
2panorama19.1 MB4.0 MB23.1 MB0.3 KB/s5.6 KB23:51:28
3poznan378.4 KB103.3 KB481.6 KB0.0 KB/s2.8 KB24:02:32
4nask52.3 KB0.0 KB52.3 KB0.0 KB/s3.5 KB24:00:27
5task22.1 KB12.5 KB34.6 KB0.0 KB/s2.5 KB21:48:45
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:04
TOTAL: 6308.2 MB762.0 MB1.0 GB2.1 KB/s107.2 KB141:36:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 348486.9 KB 288 0 000:00:15
2lze200.lze.lodz.pl 8 226444.0 KB 11 0 002:00:21
3web.man.lodz.pl 288 136132.7 KB 55 0 000:00:30
4212.191.78.190 301 71131.4 KB 46 2 041:47:43
5router2.cbmm.lodz.pl 1 58.9 KB 1 0 000:01:03
6212.51.203.199 2 13.9 KB 1 0 000:03:50
7kujawiak.man.lodz.pl 5 00.0 KB 0 5 000:00:01
TOTAL: 7 893 7871.2 MB 402 7 074:29:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 348486.9 KB 288 0 000:00:15
2*.lze.lodz.pl 8 226444.0 KB 11 0 002:00:21
3*.man.lodz.pl 678 136132.7 KB 55 5 000:00:37
4unresolved 303 72135.3 KB 47 2 041:51:33
5*.cbmm.lodz.pl 1 58.9 KB 1 0 000:01:03
6*.pa.nsw.optusnet.com.au 23 00.0 KB 0 0 000:00:40
7*.wroclaw.mm.pl 62 00.0 KB 0 0 010:05:31
8*.4web.pl 46 00.0 KB 0 0 007:20:14
9*.206.15.62.static.jazztel.es 4 00.0 KB 0 0 013:07:38
10*.toya.net.pl 79 00.0 KB 0 0 000:01:23
TOTAL: 101492 7871.2 MB 402 7 074:29:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.772 4.276 0.00041:47:43
241.206.15.62.static.jazztel.es 2.956 4.136 0.00013:07:38
host-89-231-50-15.wroclaw.mm.pl 0.120 0.868 0.00010:05:31
net133-43.4web.pl 0.124 0.620 0.00007:20:14
lze200.lze.lodz.pl 0.068 0.168 0.00002:00:21
212.51.203.199 0.000 0.032 0.00000:03:50
staticline41435.toya.net.pl 0.172 1.124 0.00000:01:23
router2.cbmm.lodz.pl 0.004 0.016 0.00000:01:03
pa49-181-246-44.pa.nsw.optusnet.com.au 0.068 0.300 0.00000:00:40
web.man.lodz.pl 0.636 4.356 0.00000:00:30
vegas.cm.p.lodz.pl 0.700 4.208 0.00000:00:15
mon.man.lodz.pl 0.712 3.976 0.00000:00:04
david.man.lodz.pl 0.208 1.328 0.00000:00:01
kujawiak.man.lodz.pl 0.020 0.096 0.00000:00:01
? 0.000 0.024 0.00000:00:00
TOTAL: 15 6.560 25.528 0.00074:29:21

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 289
david.man.lodz.pl 96
staticline41435.toya.net.pl 79
host-89-231-50-15.wroclaw.mm.pl 62
net133-43.4web.pl 46
pa49-181-246-44.pa.nsw.optusnet.com.au 23
241.206.15.62.static.jazztel.es 4
TOTAL: 7 599

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
241.206.15.62.static.jazztel.es 2 0
lze200.lze.lodz.pl 1 0
TOTAL: 2 3 7

Newsgroup request counts (by category):

CategoryCountPct
1pl 439 55.8%
2lodman 348 44.2%
TOTAL: 2 787100.0%

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

NewsgroupCount
1lodman.info 348
2pl.comp.pecet 121
3pl.misc.telefonia.gsm 87
4pl.comp.os.ms-windows.winnt 73
5pl.rec.kuchnia 61
6pl.regionalne.lodz 23
7pl.comp.os.linux 22
8pl.misc.kolej 19
9pl.soc.prawo 12
10pl.rec.rowery 8
11pl.regionalne.warszawa 4
12pl.rec.dom 4
13pl.rec.gory 2
14pl.praca.dyskusje 1
15pl.rec.radio.amatorskie 1
16pl.comp.os.linux.sieci 1
TOTAL: 16 787