Daily Usenet report

Oct 17 04:15:04 -- Oct 18 04:15:02

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Oct 17 11:23:35 newsfeed innfeed[2569]: task:0 connect: Network is unreachable
Oct 17 11:23:35 newsfeed innfeed[2569]: nask:0 connect: Network is unreachable
Oct 17 11:23:35 newsfeed innfeed[2569]: icm:0 connect: Network is unreachable
Oct 17 13:05:15 newsfeed nnrpd[15253]: SERVER perl filter not defined
Oct 17 13:10:03 newsfeed pgpverify[15339]: pgpverify: verification failed
Oct 17 16:12:39 newsfeed nnrpd[21369]: SERVER perl filter not defined
Oct 17 16:48:07 newsfeed overchan[2600]: input line too long, skipping
Oct 17 17:53:30 newsfeed nnrpd[24600]: SERVER perl filter not defined
Oct 17 18:04:07 newsfeed nnrpd[24951]: SERVER perl filter not defined
Oct 17 21:28:44 newsfeed overchan[2600]: input line too long, skipping
Oct 17 21:42:13 newsfeed overchan[2600]: input line too long, skipping
Oct 17 22:50:32 newsfeed nnrpd[2107]: SERVER perl filter not defined
Oct 18 00:59:19 newsfeed overchan[2600]: input line too long, skipping
Oct 18 01:31:16 newsfeed overchan[2600]: input line too long, skipping
Oct 18 01:40:08 newsfeed overchan[2600]: input line too long, skipping
Oct 18 02:26:14 newsfeed overchan[2600]: input line too long, skipping
Oct 18 02:27:59 newsfeed overchan[2600]: input line too long, skipping
Oct 18 02:54:35 newsfeed overchan[2600]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2174432 98.4%245.4 MB 97.9%
innd 17825 0.8%2.9 MB 1.2%
nnrpd 11559 0.5%1.2 MB 0.5%
innfeed 7070 0.3%1.1 MB 0.4%
overchan 9 0.0%1.3 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 72210900 100.0%250.6 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2167952 94.7%
Negative hits 82486 3.6%
Positive hits 38958 1.7%
Cache misses 360 0.0%
TOTAL: 4 2289756 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:09.764 0.0%403 0.000 24.228 418.000
article cleanup00:00:30.022 0.0%2173848 0.002 0.014 0.026
article logging00:01:04.487 0.1%2174009 0.013 0.030 0.305
article parse01:06:38.191 4.6%70981711 0.007 0.056 0.097
article write00:21:08.626 1.5%2167836 0.304 0.585 1.569
artlog/artcncl00:00:00.007 0.0%398 0.000 0.018 1.000
artlog/artparse00:00:00.001 0.0%4 0.000 0.250 1.000
data move00:02:39.981 0.2%83834686 0.000 0.002 0.015
hisgrep/artcncl00:00:01.706 0.0%309 0.000 5.521 125.000
hishave/artcncl00:00:02.578 0.0%403 0.000 6.397 308.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:58:22.679 12.4%2291855 0.838 4.670 35.419
history sync00:00:00.299 0.0%291 0.000 1.027 285.000
history write04:03:17.848 16.9%2170104 2.452 6.727 84.630
hiswrite/artcncl00:00:00.335 0.0%94 0.000 3.564 25.000
idle08:56:20.360 37.3%37506357 0.212 0.858 117.452
nntp read00:37:08.812 2.6%69246588 0.009 0.032 0.049
overview write00:00:13.793 0.0%2167836 0.000 0.006 0.025
perl filter05:29:57.641 22.9%2170100 4.501 9.123 11.476
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:19.162 0.3%4376366 0.013 0.059 0.122
TOTAL: 23:59:20.37023:41:56.292 98.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.162 0.0%40795 0.000 0.004 0.143
article prepare00:00:00.009 0.0%46974 0.000 0.000 0.250
article read00:00:01.462 0.0%11096 0.000 0.132 19.600
backlog stats00:00:00.247 0.0%309618 0.000 0.001 0.029
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:02.299 0.0%181619 0.000 0.013 0.111
data write00:00:05.560 0.0%157772 0.000 0.035 1.000
idle23:58:14.241100.0%309618 0.000 278.712 17785.000
status file00:00:01.710 0.0%279 0.000 6.129 268.000
TOTAL: 23:58:33.01423:58:25.690100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle61:59:27.903100.0%434866 0.000 513.188504828.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:14.811 0.0%872837 0.000 0.017 4.111
readart00:00:05.395 0.0%723 0.000 7.462 71.111
TOTAL: 62:00:57.70161:59:48.109100.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 753 21598122153346 2513 3953 99%430:20:25
2news.task.gda.pl 18 29758 6362 21924 1472 21%41:34:15
3news.nask.pl 3 15815 6006 9265 544 37%22:26:01
4news.icm.edu.pl 39 275 20 248 7 7%18:02:46
5localhost 6 5 5 0 0 100%00:00:00
TOTAL: 5 819 22056652165739 33950 5976 98%512:23:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl761.8 GB14.8 MB33.6 MB761.9 GB 99%370.3 KB
2news.nask.pl23.9 MB1.4 MB1.5 MB26.8 MB 89%4.2 KB
3news.task.gda.pl13.3 MB43.5 KB4.4 MB17.7 MB 75%2.3 KB
4news.icm.edu.pl654.1 KB0.0 KB628.5 KB1.3 MB 50%47.5 KB
5localhost8.1 KB0.0 KB0.0 KB8.1 KB100%1.6 KB
TOTAL: 5761.8 GB16.3 MB40.0 MB761.9 GB 99%367.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 17 04:15:04 - 04:59:59 69415 3.2% 25.7524.7 GB 3.2%9592.70
Oct 17 05:00:00 - 05:59:59 95524 4.4% 26.5334.2 GB 4.5%9967.59
Oct 17 06:00:00 - 06:59:59 88506 4.1% 24.5934.7 GB 4.6%10115.98
Oct 17 07:00:00 - 07:59:59 78748 3.6% 21.8728.0 GB 3.7%8144.85
Oct 17 08:00:00 - 08:59:59 97625 4.5% 27.1233.9 GB 4.4%9864.23
Oct 17 09:00:00 - 09:59:59 102363 4.7% 28.4337.7 GB 4.9%10973.66
Oct 17 10:00:00 - 10:59:59 76121 3.5% 21.1428.7 GB 3.8%8348.39
Oct 17 11:00:00 - 11:59:59 78051 3.6% 21.6828.0 GB 3.7%8147.11
Oct 17 12:00:00 - 12:59:59 76059 3.5% 21.1326.7 GB 3.5%7784.76
Oct 17 13:00:00 - 13:59:59 104769 4.8% 29.1035.8 GB 4.7%10426.66
Oct 17 14:00:00 - 14:59:59 70595 3.3% 19.6123.4 GB 3.1%6820.21
Oct 17 15:00:00 - 15:59:59 105410 4.9% 29.2834.8 GB 4.6%10126.03
Oct 17 16:00:00 - 16:59:59 103433 4.8% 28.7334.5 GB 4.5%10053.53
Oct 17 17:00:00 - 17:59:59 108018 5.0% 30.0037.1 GB 4.9%10816.64
Oct 17 18:00:00 - 18:59:59 107911 5.0% 29.9837.0 GB 4.9%10789.70
Oct 17 19:00:00 - 19:59:59 85565 3.9% 23.7728.7 GB 3.8%8352.69
Oct 17 20:00:00 - 20:59:59 82830 3.8% 23.0127.8 GB 3.6%8087.46
Oct 17 21:00:00 - 21:59:59 98552 4.5% 27.3832.9 GB 4.3%9576.25
Oct 17 22:00:00 - 22:59:59 101230 4.7% 28.1234.6 GB 4.5%10075.82
Oct 17 23:00:00 - 23:59:59 93605 4.3% 26.0033.0 GB 4.3%9619.26
Oct 18 00:00:00 - 00:59:59 63980 3.0% 17.7724.0 GB 3.2%6996.46
Oct 18 01:00:00 - 01:59:59 76138 3.5% 21.1527.7 GB 3.6%8062.41
Oct 18 02:00:00 - 02:59:59 78960 3.6% 21.9329.0 GB 3.8%8446.93
Oct 18 03:00:00 - 03:59:59 99080 4.6% 27.5236.1 GB 4.7%10526.76
Oct 18 04:00:00 - 04:15:02 25363 1.2% 28.129.3 GB 1.2%10833.66
TOTAL: 23:59:58 2167851 100.0% 25.09762.3 GB 100.0%9251.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4072 264 0 3156 2 0 0 0 650
2news.task.gda.pl 1474 1269 0 24 2 0 0 0 179
3news.nask.pl 630 11 0 573 5 0 0 0 41
4news.icm.edu.pl 7 0 0 0 0 0 0 0 7
TOTAL: 4 6183 1544 0 3753 9 0 0 0 877

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 133
mailing.freebsd.svn-ports-head 130
uk.railway 102
mailing.freebsd.ports-bugs 74
mailing.gcc.gcc-cvs 67
fr.usenet.abus.nocem 57
mailing.freebsd.ports 50
mailing.unix.samba-technical 47
fr.rec.loisirs-creatifs 45
it.tlc.cellulari.android 44
mozilla.dev.platform 41
alt.politics.scorched-earth 39
it.comp.os.win.windows8 37
mailing.freebsd.svn-src-all 35
fa.freebsd.cvs-all 35
mailing.database.pgsql-general 32
mailing.freebsd.svn-src-head 31
mailing.openbsd.ports-changes 30
mailing.openbsd.source-changes 28
gmane.linux.alsa.devel 27
TOTAL: 82 1544

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

GroupsCount
pl.sci.matematyka 3
pl.sci.historia 3
fr.comp.securite 1
bit.listserv.catholic 1
fr.comp.applications.libres 1
TOTAL: 5 9

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 543
EMP (fsl) 156
EMP (md5) 6
HTML post 6
Scoring filter (8) 1
TOTAL: 5 712

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 42381 4053 35511 972 0 0 9%23:56:34
2icm 57275 3669 31173 2696 7 79 6%24:00:33
3task 2128 135 1061 14 0 13 6%21:28:25
4poznan 15081 104 12384 41 0 0 0%23:52:53
5nask 18285 55 12566 0 0 13 0%23:50:32
6okapi 0 0 0 0 0 2664 0%24:00:01
TOTAL: 6 135150 8016 92695 3723 7 2769 5%141:08:58
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm28.6 MB1.1 GB1.1 GB13.3 KB/s181.0 KB24:00:33
2panorama13.5 MB3.9 MB17.4 MB0.2 KB/s3.6 KB23:56:34
3poznan351.4 KB69.5 KB420.8 KB0.0 KB/s2.9 KB23:52:53
4task284.0 KB25.2 KB309.3 KB0.0 KB/s2.1 KB21:28:25
5nask184.8 KB0.0 KB184.8 KB0.0 KB/s3.4 KB23:50:32
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 642.9 MB1.1 GB1.1 GB2.3 KB/s99.7 KB141:08:58
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 336521.8 KB 288 0 000:00:11
2lze200.lze.lodz.pl 16 236445.7 KB 15 0 002:38:39
3212.191.78.190 269 108205.3 KB 39 1 041:40:58
4web.man.lodz.pl 288 4040.4 KB 19 0 000:00:24
5adbi179.neoplus.adsl.tpnet.pl 2 23.4 KB 1 0 000:02:23
6router2.cbmm.lodz.pl 4 11.6 KB 1 0 000:09:47
7kujawiak.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 7 871 7231.2 MB 363 5 062:00:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 336521.8 KB 288 0 000:00:11
2*.lze.lodz.pl 16 236445.7 KB 15 0 002:38:39
3unresolved 564 108205.3 KB 39 1 041:48:53
4*.man.lodz.pl 678 4040.4 KB 19 4 000:00:31
5*.neoplus.adsl.tpnet.pl 4 23.4 KB 1 0 000:32:30
6*.cbmm.lodz.pl 4 11.6 KB 1 0 000:09:47
7*.191.14.62.static.jazztel.es 3 00.0 KB 0 0 016:07:23
8*.adsl.inetia.pl 2 00.0 KB 0 0 000:00:04
9*.internetdsl.tpnet.pl 5 00.0 KB 0 0 000:00:01
10*.105.135.22.tvsat364.lodz.pl 3 00.0 KB 0 0 000:42:46
11*.toya.net.pl 78 00.0 KB 0 0 000:00:07
TOTAL: 111645 7231.2 MB 363 5 062:00:56

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.696 3.236 0.00041:40:58
16.191.14.62.static.jazztel.es 25.941 41.750 0.00016:07:23
lze200.lze.lodz.pl 0.056 0.360 0.00002:38:39
ip-176.105.135.22.tvsat364.lodz.pl 0.012 0.032 0.00000:42:46
ece156.neoplus.adsl.tpnet.pl 0.000 0.024 0.00000:30:07
router2.cbmm.lodz.pl 0.012 0.044 0.00000:09:47
122.150.26.2 0.704 2.808 0.00000:07:55
adbi179.neoplus.adsl.tpnet.pl 0.020 0.016 0.00000:02:23
web.man.lodz.pl 0.660 3.280 0.00000:00:24
vegas.cm.p.lodz.pl 0.640 3.380 0.00000:00:11
staticline41435.toya.net.pl 0.164 0.972 0.00000:00:07
178-36-242-44.adsl.inetia.pl 0.000 0.040 0.00000:00:04
f-oper-v100.man.lodz.pl 0.508 2.780 0.00000:00:03
david.man.lodz.pl 0.196 1.164 0.00000:00:02
gcq193.internetdsl.tpnet.pl 0.028 0.040 0.00000:00:01
kujawiak.man.lodz.pl 0.012 0.056 0.00000:00:00
? 0.004 0.016 0.00000:00:00
TOTAL: 17 29.653 59.998 0.00062:00:56

Curious NNRP server explorers [Top 20]:

SystemConn
122.150.26.2 295
f-oper-v100.man.lodz.pl 290
david.man.lodz.pl 96
staticline41435.toya.net.pl 78
gcq193.internetdsl.tpnet.pl 5
ip-176.105.135.22.tvsat364.lodz.pl 3
16.191.14.62.static.jazztel.es 3
ece156.neoplus.adsl.tpnet.pl 2
178-36-242-44.adsl.inetia.pl 2
TOTAL: 9 774

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
ece156.neoplus.adsl.tpnet.pl 1 0
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 385 53.3%
2lodman 338 46.7%
TOTAL: 2 723100.0%

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

NewsgroupCount
1lodman.info 338
2pl.comp.pecet 116
3pl.rec.kuchnia 88
4pl.rec.rowery 46
5pl.misc.kolej 25
6pl.rec.dom 25
7pl.soc.prawo 18
8pl.regionalne.warszawa 15
9pl.comp.os.ms-windows.winnt 14
10pl.regionalne.lodz 12
11pl.comp.os.linux 9
12pl.misc.telefonia.gsm 7
13pl.rec.gory 6
14pl.comp.os.linux.sieci 4
TOTAL: 14 723