Daily Usenet report

Jun 4 04:15:02 -- Jun 5 04:15:03

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Jun 4 11:50:09 newsfeed pgpverify[4905]: pgpverify: verification failed
Jun 4 13:01:12 newsfeed nnrpd[7278]: SERVER perl filter not defined
Jun 4 13:15:59 newsfeed nnrpd[7848]: SERVER perl filter not defined
Jun 4 13:25:48 newsfeed nnrpd[8182]: SERVER perl filter not defined
Jun 4 13:35:35 newsfeed nnrpd[8511]: SERVER perl filter not defined
Jun 4 13:40:10 newsfeed nnrpd[8601]: SERVER perl filter not defined
Jun 4 13:53:39 newsfeed nnrpd[9100]: SERVER perl filter not defined
Jun 4 13:54:30 newsfeed nnrpd[9120]: SERVER perl filter not defined
Jun 4 15:31:45 newsfeed nnrpd[12301]: SERVER perl filter not defined
Jun 4 15:32:56 newsfeed nnrpd[12322]: SERVER perl filter not defined
Jun 4 15:34:18 newsfeed nnrpd[12485]: SERVER perl filter not defined
Jun 4 15:35:04 newsfeed nnrpd[12536]: SERVER perl filter not defined
Jun 4 15:39:38 newsfeed nnrpd[12585]: SERVER perl filter not defined
Jun 4 16:20:46 newsfeed nnrpd[14200]: SERVER perl filter not defined
Jun 4 16:22:51 newsfeed nnrpd[14220]: SERVER perl filter not defined
Jun 4 16:28:42 newsfeed nnrpd[14456]: SERVER perl filter not defined
Jun 4 16:29:44 newsfeed nnrpd[14482]: SERVER perl filter not defined
Jun 4 17:51:01 newsfeed nnrpd[17200]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1843374 98.2%208.8 MB 97.7%
innd 16551 0.9%2.8 MB 1.3%
nnrpd 10242 0.5%1.1 MB 0.5%
innfeed 6830 0.4%1.0 MB 0.5%
controlchan 3 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 61877001 100.0%213.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1837997 94.4%
Negative hits 69005 3.5%
Positive hits 40179 2.1%
Cache misses 248 0.0%
TOTAL: 4 1947429 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:13.392 0.0%351 0.000 38.154 1184.000
article cleanup00:00:30.276 0.0%1843582 0.004 0.016 0.031
article logging00:00:56.860 0.1%1843719 0.012 0.031 0.602
article parse01:13:56.884 5.1%179103925 0.008 0.025 0.068
article write00:23:02.003 1.6%1836860 0.299 0.752 3.177
artlog/artcncl00:00:00.008 0.0%346 0.000 0.023 1.000
artlog/artparse00:00:00.001 0.0%6 0.000 0.167 0.250
data move00:03:48.574 0.3%191531571 0.000 0.001 0.030
hisgrep/artcncl00:00:01.336 0.0%285 0.000 4.688 305.000
hishave/artcncl00:00:01.416 0.0%351 0.000 4.034 63.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:58:35.538 12.4%1948399 0.047 5.500 14.956
history sync00:00:00.014 0.0%291 0.000 0.048 1.000
history write04:27:47.843 18.6%1839036 2.833 8.737 24.939
hiswrite/artcncl00:00:00.874 0.0%66 0.000 13.242 207.000
idle08:26:01.123 35.1%118077995 0.164 0.257 1.375
nntp read01:05:48.581 4.6%177719939 0.009 0.022 0.048
overview write00:00:11.693 0.0%1836860 0.000 0.006 0.017
perl filter04:29:59.225 18.7%1839030 5.481 8.809 11.199
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:35.289 0.2%3744806 0.029 0.057 0.120
TOTAL: 24:00:37.82223:14:30.930 96.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.250 0.0%71069 0.000 0.004 0.111
article prepare00:00:00.013 0.0%58002 0.000 0.000 0.028
article read00:00:05.021 0.0%13873 0.000 0.362 120.821
backlog stats00:00:00.283 0.0%408755 0.000 0.001 0.024
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:02.708 0.0%242401 0.000 0.011 1.000
data write00:00:09.449 0.0%192470 0.000 0.049 1.221
idle23:58:43.577100.0%408755 0.000 211.187 13063.000
status file00:00:01.075 0.0%225 0.000 4.778 103.750
TOTAL: 23:59:11.14523:59:02.376100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:28:00.348 99.8%7374 0.000 2668.884450305.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.399 0.0%17532 0.000 0.023 0.500
readart00:00:01.455 0.0%585 0.000 2.487 95.000
TOTAL: 05:28:45.79805:28:02.202 99.8%----

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
admin@openwatcom.news-admin.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 862 18309651825357 1493 4115 99%332:36:00
2news.task.gda.pl 13 29377 5570 22292 1515 18%46:07:52
3news.nask.pl 2 18389 5521 11780 1088 30%24:22:31
4localhost 18 17 17 0 0 100%00:00:01
5news.icm.edu.pl 41 204 6 179 19 2%15:09:13
TOTAL: 5 936 18789521836471 35744 6737 97%418:15:37
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl643.3 GB11.7 MB19.5 MB643.4 GB 99%368.8 KB
2news.nask.pl17.9 MB3.0 MB3.1 MB24.1 MB 74%3.7 KB
3news.task.gda.pl13.1 MB47.5 KB4.4 MB17.6 MB 74%2.5 KB
4news.icm.edu.pl72.8 KB64.5 KB324.5 KB461.8 KB 15%18.5 KB
5localhost28.3 KB0.0 KB0.0 KB28.3 KB100%1.7 KB
TOTAL: 5643.4 GB14.8 MB27.4 MB643.4 GB 99%366.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 4 04:15:02 - 04:59:59 50918 2.8% 18.8720.0 GB 3.1%7764.35
Jun 4 05:00:00 - 05:59:59 71729 3.9% 19.9227.5 GB 4.3%8005.43
Jun 4 06:00:00 - 06:59:59 74123 4.0% 20.5927.7 GB 4.3%8077.91
Jun 4 07:00:00 - 07:59:59 67689 3.7% 18.8025.2 GB 3.9%7341.50
Jun 4 08:00:00 - 08:59:59 84074 4.6% 23.3530.3 GB 4.7%8818.04
Jun 4 09:00:00 - 09:59:59 86139 4.7% 23.9330.1 GB 4.7%8768.13
Jun 4 10:00:00 - 10:59:59 86697 4.7% 24.0829.6 GB 4.6%8635.17
Jun 4 11:00:00 - 11:59:59 68339 3.7% 18.9824.7 GB 3.8%7198.46
Jun 4 12:00:00 - 12:59:59 86329 4.7% 23.9831.4 GB 4.9%9140.75
Jun 4 13:00:00 - 13:59:59 86284 4.7% 23.9730.7 GB 4.8%8955.55
Jun 4 14:00:00 - 14:59:59 91134 5.0% 25.3230.4 GB 4.7%8844.11
Jun 4 15:00:00 - 15:59:59 97800 5.3% 27.1729.5 GB 4.6%8584.93
Jun 4 16:00:00 - 16:59:59 92825 5.1% 25.7830.6 GB 4.8%8915.32
Jun 4 17:00:00 - 17:59:59 88982 4.8% 24.7230.0 GB 4.7%8744.50
Jun 4 18:00:00 - 18:59:59 73659 4.0% 20.4626.8 GB 4.2%7797.13
Jun 4 19:00:00 - 19:59:59 71133 3.9% 19.7624.8 GB 3.9%7219.98
Jun 4 20:00:00 - 20:59:59 87358 4.8% 24.2729.9 GB 4.7%8711.94
Jun 4 21:00:00 - 21:59:59 55002 3.0% 15.2819.3 GB 3.0%5632.14
Jun 4 22:00:00 - 22:59:59 36140 2.0% 10.0411.9 GB 1.8%3465.04
Jun 4 23:00:00 - 23:59:59 42384 2.3% 11.7715.0 GB 2.3%4366.03
Jun 5 00:00:00 - 00:59:59 61229 3.3% 17.0121.4 GB 3.3%6219.92
Jun 5 01:00:00 - 01:59:59 79330 4.3% 22.0428.3 GB 4.4%8241.43
Jun 5 02:00:00 - 02:59:59 86975 4.7% 24.1630.6 GB 4.8%8921.94
Jun 5 03:00:00 - 03:59:59 89096 4.9% 24.7530.4 GB 4.7%8854.08
Jun 5 04:00:00 - 04:15:03 20799 1.1% 23.037.0 GB 1.1%8170.65
TOTAL: 24:00:01 1836167 100.0% 21.25643.1 GB 100.0%7805.24
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4239 299 0 3496 5 0 0 0 439
2news.task.gda.pl 1515 1308 0 26 0 0 0 0 181
3news.nask.pl 1088 10 0 1025 11 0 0 0 42
4news.icm.edu.pl 19 0 0 1 0 0 0 0 18
TOTAL: 4 6861 1617 0 4548 16 0 0 0 680

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.ports-bugs 184
uk.railway 166
mailing.freebsd.svn-ports-all 165
mailing.freebsd.svn-ports-head 164
mailing.freebsd.svn-src-all 62
fa.freebsd.cvs-all 54
24hoursupport.helpdesk 53
alt.windows7.general 51
mailing.gcc.gcc-cvs 43
alt.politics.scorched-earth 41
mozilla.dev.platform 37
mailing.unix.samba 37
it.tlc.cellulari.android 37
mailing.freebsd.ports 36
gmane.linux.alsa.devel 35
mailing.freebsd.svn-src-head 29
mailing.openbsd.ports-changes 27
nl.comp.sys.android 25
mailing.openbsd.source-changes 23
mozilla.dev.gaia 21
TOTAL: 79 1617

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

GroupsCount
pl.sci.historia 15
bit.listserv.catholic 1
TOTAL: 2 16

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 298
EMP (fsl) 168
EMP (md5) 51
Attached HTML file 13
HTML post 6
Scoring filter (12) 1
TOTAL: 6 537

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 54165 7785 25126 4056 21 9 14%23:59:56
2panorama 75345 1925 68573 614 0 1 2%24:03:51
3poznan 13136 46 10924 13 0 0 0%24:06:10
4nask 20639 33 13744 0 0 0 0%23:58:58
5task 1832 20 967 8 0 0 1%21:41:53
6okapi 0 0 0 0 0 2956 0%24:00:02
TOTAL: 6 165117 9809 119334 4691 21 2966 5%141:50:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm100.7 MB1.1 GB1.2 GB14.9 KB/s108.8 KB23:59:56
2panorama6.2 MB45.7 MB51.9 MB0.6 KB/s20.9 KB24:03:51
3poznan120.0 KB25.1 KB145.1 KB0.0 KB/s2.5 KB24:06:10
4nask115.6 KB0.0 KB115.6 KB0.0 KB/s3.5 KB23:58:58
5task43.0 KB15.9 KB59.0 KB0.0 KB/s2.1 KB21:41:53
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
TOTAL: 6107.2 MB1.2 GB1.3 GB2.6 KB/s92.5 KB141:50:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 287 413622.2 KB 287 0 000:00:10
2web.man.lodz.pl 288 104118.6 KB 41 0 000:00:27
3lze200.lze.lodz.pl 10 3357.3 KB 9 0 001:43:20
4net-93-148-156-33.cust.dsl.teletu.it 36 2015.8 KB 10 0 000:00:13
5194.33.77.50 2 1221.9 KB 1 0 000:01:30
6proxy.filmschool.lodz.pl 1 11.5 KB 1 0 000:07:10
7port1422.ds1-suoe.adsl.cybercity.dk 2 10.8 KB 1 0 000:00:01
8isvcs01.man.lodz.pl 17 00.0 KB 0 17 000:00:02
TOTAL: 8 643 584838.2 KB 350 17 005:28:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 287 413622.2 KB 287 0 000:00:10
2*.man.lodz.pl 689 104118.6 KB 41 17 000:00:37
3*.lze.lodz.pl 10 3357.3 KB 9 0 001:43:20
4*.cust.dsl.teletu.it 36 2015.8 KB 10 0 000:00:13
5unresolved 2 1221.9 KB 1 0 000:01:30
6*.ds1-suoe.adsl.cybercity.dk 2 10.8 KB 1 0 000:00:01
7*.filmschool.lodz.pl 1 11.5 KB 1 0 000:07:10
8*.pa.nsw.optusnet.com.au 680 00.0 KB 0 0 000:49:34
9*.wroclaw.mm.pl 16 00.0 KB 0 0 002:35:09
10*.105.135.22.tvsat364.lodz.pl 2 00.0 KB 0 0 000:10:50
11*.toya.net.pl 48 00.0 KB 0 0 000:00:06
TOTAL: 111773 584838.2 KB 350 17 005:28:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
host-89-231-50-15.wroclaw.mm.pl 0.048 0.196 0.00002:35:09
lze200.lze.lodz.pl 0.020 0.180 0.00001:43:20
pa49-181-246-147.pa.nsw.optusnet.com.au 1.632 9.268 0.00000:49:34
ip-176.105.135.22.tvsat364.lodz.pl 0.000 0.036 0.00000:10:50
proxy.filmschool.lodz.pl 0.004 0.012 0.00000:07:10
194.33.77.50 0.004 0.032 0.00000:01:30
web.man.lodz.pl 0.752 4.528 0.00000:00:27
net-93-148-156-33.cust.dsl.teletu.it 0.128 0.476 0.00000:00:13
pc-skrzep2.cm.p.lodz.pl 0.628 4.036 0.00000:00:10
staticline41435.toya.net.pl 0.084 0.692 0.00000:00:06
mon.man.lodz.pl 0.664 4.164 0.00000:00:05
isvcs01.man.lodz.pl 0.048 0.352 0.00000:00:02
david.man.lodz.pl 0.208 1.432 0.00000:00:01
port1422.ds1-suoe.adsl.cybercity.dk 0.036 0.036 0.00000:00:01
TOTAL: 14 4.256 25.440 0.00005:28:44

Curious NNRP server explorers [Top 20]:

SystemConn
pa49-181-246-147.pa.nsw.optusnet.com.au 680
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 48
host-89-231-50-15.wroclaw.mm.pl 16
ip-176.105.135.22.tvsat364.lodz.pl 2
TOTAL: 6 1130

NNRP client timeouts [Top 20]:

SystemConnPeer
lze200.lze.lodz.pl 3 0
pa49-181-246-147.pa.nsw.optusnet.com.au 1 0
TOTAL: 2 4 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 441 75.5%
2pl 130 22.3%
3lodz 9 1.5%
4lodzman 4 0.7%
TOTAL: 4 584100.0%

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

NewsgroupCount
1lodman.info 429
2pl.comp.pecet 78
3pl.comp.os.ms-windows.winnt 28
4pl.misc.telefonia.gsm 15
5lodman.test 12
6pl.rec.kuchnia 6
7lodz.test 5
8lodz.ogloszenia 4
9lodzman.test 4
10pl.comp.os.linux 2
11pl.rec.foto.cyfrowa 1
TOTAL: 11 584