Daily Usenet report

Jul 11 04:15:04 -- Jul 12 04:15:02

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Jul 11 13:33:28 newsfeed nnrpd[29928]: SERVER perl filter not defined
Jul 11 14:41:48 newsfeed nnrpd[32081]: SERVER perl filter not defined
Jul 11 15:15:02 newsfeed nnrpd[624]: unable to get certificate from '/etc/news/cert.pem'
Jul 11 15:15:02 newsfeed nnrpd[624]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Jul 11 15:55:53 newsfeed nnrpd[1932]: SERVER perl filter not defined
Jul 11 17:26:32 newsfeed nnrpd[4863]: SERVER perl filter not defined
Jul 11 17:26:44 newsfeed nnrpd[4864]: SERVER perl filter not defined
Jul 11 21:34:07 newsfeed nnrpd[12664]: SERVER perl filter not defined
Jul 11 21:35:22 newsfeed nnrpd[12708]: SERVER perl filter not defined
Jul 11 21:36:40 newsfeed nnrpd[12710]: SERVER perl filter not defined
Jul 11 21:37:22 newsfeed nnrpd[12716]: SERVER perl filter not defined
Jul 11 21:38:02 newsfeed nnrpd[12718]: SERVER perl filter not defined
Jul 11 22:39:41 newsfeed nnrpd[14638]: SERVER perl filter not defined
Jul 11 22:41:08 newsfeed nnrpd[14825]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1366294 98.0%154.0 MB 97.5%
innd 12934 0.9%2.1 MB 1.4%
nnrpd 7818 0.6%827.5 KB 0.5%
innfeed 7271 0.5%1.0 MB 0.7%
TOTAL: 41394317 100.0%158.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1361751 93.8%
Negative hits 53182 3.7%
Positive hits 37162 2.6%
Cache misses 226 0.0%
TOTAL: 4 1452321 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.106 0.0%386 0.000 15.819 284.000
article cleanup00:00:17.935 0.0%1365288 0.000 0.013 0.036
article logging00:00:37.487 0.0%1365502 0.006 0.027 0.542
article parse00:48:44.921 3.4%74694235 0.015 0.039 0.082
article write00:16:50.725 1.2%1360039 0.202 0.743 1.817
artlog/artcncl00:00:00.011 0.0%363 0.000 0.030 1.000
data move00:01:29.187 0.1%83653189 0.000 0.001 0.004
hisgrep/artcncl00:00:01.393 0.0%282 0.000 4.940 88.667
hishave/artcncl00:00:00.687 0.0%386 0.000 1.780 204.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:56:08.614 8.1%1452609 0.074 4.797 14.977
history sync00:00:00.044 0.0%292 0.000 0.151 24.000
history write02:47:12.709 11.6%1362209 0.760 7.365 32.142
hiswrite/artcncl00:00:00.683 0.0%104 0.000 6.567 284.000
idle13:32:13.936 56.4%58795513 0.281 0.829 7.004
nntp read00:34:01.751 2.4%73722016 0.013 0.028 0.040
overview write00:00:08.131 0.0%1360039 0.000 0.006 0.021
perl filter03:33:11.381 14.8%1362161 3.599 9.391 12.735
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:02:17.950 0.2%2764412 0.024 0.050 0.090
TOTAL: 23:59:40.76423:33:23.651 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.165 0.0%44350 0.000 0.004 0.167
article prepare00:00:00.019 0.0%55834 0.000 0.000 0.083
article read00:00:02.167 0.0%13380 0.000 0.162 19.667
backlog stats00:00:00.244 0.0%364091 0.000 0.001 0.021
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.023 0.0%206954 0.000 0.010 1.000
data write00:00:06.520 0.0%180614 0.000 0.036 0.139
idle23:59:38.731100.0%364091 0.000 237.245 11826.000
status file00:00:01.082 0.0%213 0.000 5.080 172.500
TOTAL: 23:59:58.60123:59:50.951100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle15:09:20.521100.0%23029 0.000 2369.209473129.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.693 0.0%47984 0.000 0.014 0.667
readart00:00:00.661 0.0%500 0.000 1.322 15.000
TOTAL: 15:09:41.75715:09:21.875100.0%----

Control commands to INND:

CommandNumber
L 1
flush 24
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 189

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 498 13559791351134 1882 2963 99%240:06:48
2news.task.gda.pl 9 26549 5115 20116 1318 19%46:19:14
3news.nask.pl 4 16773 4528 11358 887 26%23:30:05
4localhost 13 12 12 0 0 100%00:00:00
5news.icm.edu.pl 45 308 8 254 46 2%17:28:22
TOTAL: 5 569 13996211360797 33610 5214 97%327:24:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl498.5 GB12.1 MB24.0 MB498.5 GB 99%386.0 KB
2news.nask.pl14.9 MB2.2 MB2.4 MB19.5 MB 76%3.7 KB
3news.task.gda.pl11.2 MB56.1 KB4.4 MB15.7 MB 71%2.5 KB
4news.icm.edu.pl266.1 KB44.9 KB878.2 KB1.2 MB 22%22.0 KB
5localhost18.3 KB0.0 KB0.0 KB18.3 KB100%1.5 KB
TOTAL: 5498.5 GB14.4 MB31.7 MB498.5 GB 99%382.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 11 04:15:04 - 04:59:59 56349 4.1% 20.9019.0 GB 3.8%7389.84
Jul 11 05:00:00 - 05:59:59 66693 4.9% 18.5321.7 GB 4.4%6327.37
Jul 11 06:00:00 - 06:59:59 100741 7.4% 27.9834.2 GB 6.9%9960.20
Jul 11 07:00:00 - 07:59:59 94020 6.9% 26.1235.3 GB 7.1%10290.71
Jul 11 08:00:00 - 08:59:59 51976 3.8% 14.4420.2 GB 4.1%5883.04
Jul 11 09:00:00 - 09:59:59 48627 3.6% 13.5116.8 GB 3.4%4901.45
Jul 11 10:00:00 - 10:59:59 50293 3.7% 13.9716.6 GB 3.3%4847.30
Jul 11 11:00:00 - 11:59:59 46295 3.4% 12.8616.6 GB 3.3%4838.74
Jul 11 12:00:00 - 12:59:59 49932 3.7% 13.8719.6 GB 3.9%5695.49
Jul 11 13:00:00 - 13:59:59 64826 4.8% 18.0125.9 GB 5.2%7549.35
Jul 11 14:00:00 - 14:59:59 51283 3.8% 14.2521.3 GB 4.3%6190.71
Jul 11 15:00:00 - 15:59:59 45806 3.4% 12.7219.0 GB 3.8%5539.25
Jul 11 16:00:00 - 16:59:59 40757 3.0% 11.3216.1 GB 3.2%4678.59
Jul 11 17:00:00 - 17:59:59 41210 3.0% 11.4515.5 GB 3.1%4516.08
Jul 11 18:00:00 - 18:59:59 35063 2.6% 9.7412.9 GB 2.6%3763.76
Jul 11 19:00:00 - 19:59:59 38186 2.8% 10.6114.6 GB 2.9%4243.85
Jul 11 20:00:00 - 20:59:59 40270 3.0% 11.1914.3 GB 2.9%4169.38
Jul 11 21:00:00 - 21:59:59 32061 2.4% 8.9113.4 GB 2.7%3888.55
Jul 11 22:00:00 - 22:59:59 27307 2.0% 7.5910.0 GB 2.0%2922.06
Jul 11 23:00:00 - 23:59:59 21874 1.6% 6.086.4 GB 1.3%1860.37
Jul 12 00:00:00 - 00:59:59 70496 5.2% 19.5826.0 GB 5.2%7586.12
Jul 12 01:00:00 - 01:59:59 86734 6.4% 24.0933.5 GB 6.7%9755.71
Jul 12 02:00:00 - 02:59:59 81131 6.0% 22.5427.6 GB 5.5%8050.34
Jul 12 03:00:00 - 03:59:59 95658 7.0% 26.5733.5 GB 6.7%9748.68
Jul 12 04:00:00 - 04:15:02 22880 1.7% 25.378.2 GB 1.6%9501.54
TOTAL: 23:59:58 1360468 100.0% 15.75498.2 GB 100.0%6046.89
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3169 219 0 2202 1 0 0 0 747
2news.task.gda.pl 1341 1178 0 31 0 0 0 0 132
3news.nask.pl 907 11 0 842 8 0 0 0 46
4news.icm.edu.pl 46 0 0 4 0 0 0 0 42
TOTAL: 4 5463 1408 0 3079 9 0 0 0 967

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 94
mailing.freebsd.svn-ports-all 69
alt.windows7.general 69
mailing.freebsd.ports-bugs 69
mailing.freebsd.svn-ports-head 69
mailing.freebsd.svn-src-all 66
fa.freebsd.cvs-all 65
mozilla.dev.platform 53
mailing.unix.samba 45
mailing.freebsd.current 43
gmane.linux.alsa.devel 37
mozilla.dev.identity 36
gmane.linux.network 36
mailing.www.horde-bugs 33
uk.rec.cycling.moderated 32
mailing.postfix.users 32
mailing.freebsd.svn-src-head 27
mailing.openbsd.ports-changes 26
mailing.openbsd.misc 25
alt.politics.scorched-earth 22
TOTAL: 85 1408

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

GroupsCount
pl.sci.historia 7
bit.listserv.catholic 1
pl.sci.matematyka 1
TOTAL: 3 9

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 512
EMP (fsl) 111
Attached HTML file 42
EMP (md5) 37
HTML post 3
TOTAL: 5 705

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 51818 2836 40573 854 0 0 5%24:01:21
2icm 65315 1102 32465 8680 1 7 1%23:50:48
3poznan 11642 80 9651 39 0 0 0%24:07:45
4task 3134 73 1590 13 0 0 2%22:53:24
5nask 21792 10 13812 2 0 0 0%24:01:48
6okapi 0 0 0 0 0 3222 0%24:00:00
TOTAL: 6 153701 4101 98091 9588 1 3229 2%142:55:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm15.4 MB1.8 GB1.8 GB22.0 KB/s193.2 KB23:50:48
2panorama7.5 MB28.3 MB35.8 MB0.4 KB/s9.9 KB24:01:21
3poznan244.9 KB74.2 KB319.1 KB0.0 KB/s2.7 KB24:07:45
4task156.2 KB23.0 KB179.1 KB0.0 KB/s2.1 KB22:53:24
5nask109.4 KB2.5 MB2.6 MB0.0 KB/s225.1 KB24:01:48
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 623.4 MB1.8 GB1.8 GB3.8 KB/s141.0 KB142:55:06
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 372581.0 KB 288 0 000:00:06
2web.man.lodz.pl 288 9289.0 KB 42 0 000:00:19
3lze200.lze.lodz.pl 6 2041.9 KB 4 0 000:20:38
4ip-176.105.135.22.tvsat364.lodz.pl 4 610.4 KB 1 0 001:32:26
5212.191.196.1 2 610.3 KB 3 0 000:40:26
6ebt89.neoplus.adsl.tpnet.pl 3 45.9 KB 3 0 000:03:07
7kujawiak.man.lodz.pl 12 00.0 KB 0 12 000:00:01
TOTAL: 7 603 500738.4 KB 341 12 015:09:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 372581.0 KB 288 0 000:00:06
2*.man.lodz.pl 684 9289.0 KB 42 12 000:00:26
3*.lze.lodz.pl 6 2041.9 KB 4 0 000:20:38
4unresolved 75 610.3 KB 3 0 012:33:27
5*.105.135.22.tvsat364.lodz.pl 4 610.4 KB 1 0 001:32:26
6*.neoplus.adsl.tpnet.pl 3 45.9 KB 3 0 000:03:07
7*.207.15.62.static.jazztel.es 4 00.0 KB 0 0 000:39:01
8*.internetdsl.tpnet.pl 2 00.0 KB 0 0 000:00:00
9*.toya.net.pl 16 00.0 KB 0 0 000:00:24
TOTAL: 91082 500738.4 KB 341 12 015:09:41

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.148 0.912 0.00011:53:00
ip-176.105.135.22.tvsat364.lodz.pl 0.004 0.048 0.00001:32:26
212.191.196.1 0.004 0.028 0.00000:40:26
252.207.15.62.static.jazztel.es 0.772 1.184 0.00000:39:01
lze200.lze.lodz.pl 0.020 0.068 0.00000:20:38
ebt89.neoplus.adsl.tpnet.pl 0.004 0.036 0.00000:03:07
staticline41435.toya.net.pl 0.032 0.180 0.00000:00:24
web.man.lodz.pl 0.700 3.236 0.00000:00:19
vegas.cm.p.lodz.pl 0.628 3.212 0.00000:00:06
f-oper-v100.man.lodz.pl 0.632 3.572 0.00000:00:05
kujawiak.man.lodz.pl 0.088 0.128 0.00000:00:01
41.130.222.227 0.000 0.032 0.00000:00:01
david.man.lodz.pl 0.204 0.984 0.00000:00:00
gcq193.internetdsl.tpnet.pl 0.008 0.020 0.00000:00:00
TOTAL: 14 3.244 13.640 0.00015:09:41

Curious NNRP server explorers [Top 20]:

SystemConn
f-oper-v100.man.lodz.pl 288
david.man.lodz.pl 96
212.191.78.190 70
staticline41435.toya.net.pl 16
252.207.15.62.static.jazztel.es 4
41.130.222.227 3
gcq193.internetdsl.tpnet.pl 2
TOTAL: 7 479

NNRP client timeouts [Top 20]:

SystemConnPeer
ip-176.105.135.22.tvsat364.lodz.pl 2 0
TOTAL: 1 2 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 376 75.2%
2pl 124 24.8%
TOTAL: 2 500100.0%

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

NewsgroupCount
1lodman.info 376
2pl.comp.os.ms-windows.winnt 60
3pl.comp.pecet 32
4pl.rec.kuchnia 18
5pl.regionalne.lodz 9
6pl.rec.gory 2
7pl.comp.bazy-danych 2
8pl.misc.paranauki 1
TOTAL: 8 500
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>