Daily Usenet report

Feb 21 04:15:04 -- Feb 22 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Feb 21 04:39:06 newsfeed pgpverify[23293]: pgpverify: verification failed
Feb 21 08:12:03 newsfeed overchan[2239]: input line too long, skipping
Feb 21 14:11:41 newsfeed innfeed[2455]: task:0 connect: Network is unreachable
Feb 21 14:11:41 newsfeed innfeed[2455]: nask:0 connect: Network is unreachable
Feb 21 14:11:41 newsfeed innfeed[2455]: icm:0 connect: Network is unreachable
Feb 21 15:04:45 newsfeed nnrpd[14056]: SERVER perl filter not defined
Feb 21 15:17:54 newsfeed nnrpd[14468]: SERVER perl filter not defined
Feb 21 15:19:19 newsfeed nnrpd[14473]: SERVER perl filter not defined
Feb 21 15:25:30 newsfeed nnrpd[14768]: SERVER perl filter not defined
Feb 21 15:27:05 newsfeed nnrpd[14789]: SERVER perl filter not defined
Feb 21 15:41:07 newsfeed nnrpd[15344]: SERVER perl filter not defined
Feb 21 16:31:14 newsfeed nnrpd[16984]: SERVER perl filter not defined
Feb 21 16:33:29 newsfeed nnrpd[16991]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1704253 98.1%195.5 MB 97.7%
innd 16032 0.9%2.6 MB 1.3%
nnrpd 9047 0.5%937.4 KB 0.5%
innfeed 7184 0.4%1.1 MB 0.5%
controlchan 4 0.0%0.5 KB 0.0%
overchan 1 0.0%0.2 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 71736522 100.0%200.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1697265 95.0%
Negative hits 47326 2.6%
Positive hits 42041 2.4%
Cache misses 243 0.0%
TOTAL: 4 1786875 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:10.144 0.0%286 0.000 35.469 785.000
article cleanup00:00:26.229 0.0%1702992 0.002 0.015 0.030
article logging00:00:51.559 0.1%1703170 0.014 0.030 0.340
article parse01:03:39.709 4.4%168092194 0.009 0.023 0.083
article write00:15:25.084 1.1%1695982 0.341 0.545 2.138
artlog/artcncl00:00:00.010 0.0%280 0.000 0.036 1.000
artlog/artparse00:00:00.000 0.0%9 0.000 0.000 0.000
data move00:02:45.919 0.2%179160699 0.000 0.001 0.003
hisgrep/artcncl00:00:02.226 0.0%229 0.000 9.721 467.000
hishave/artcncl00:00:00.498 0.0%286 0.000 1.741 178.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:02:46.621 8.5%1788184 0.570 4.120 20.005
history sync00:00:00.014 0.0%290 0.000 0.048 1.000
history write03:24:49.460 14.2%1698688 2.076 7.235 20.657
hiswrite/artcncl00:00:00.325 0.0%57 0.000 5.702 91.500
idle11:27:47.950 47.8%122212742 0.184 0.338 5.493
nntp read00:59:09.284 4.1%166837162 0.012 0.021 0.038
overview write00:00:11.033 0.0%1695982 0.000 0.007 0.016
perl filter04:04:23.367 17.0%1698679 5.983 8.632 10.434
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:37.896 0.3%3433694 0.012 0.063 0.104
TOTAL: 23:58:31.04023:26:07.328 97.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.184 0.0%41969 0.000 0.004 0.091
article prepare00:00:00.013 0.0%60242 0.000 0.000 0.125
article read00:00:01.030 0.0%14643 0.000 0.070 1.000
backlog stats00:00:00.232 0.0%323017 0.000 0.001 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.096 0.0%192539 0.000 0.011 1.000
data write00:00:05.971 0.0%160351 0.000 0.037 1.000
idle23:59:08.551100.0%323017 0.000 267.319 11247.000
status file00:00:02.281 0.0%268 0.000 8.511 215.000
TOTAL: 23:59:27.43723:59:20.358100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.156 0.0%35 4.457 4.457 4.457
idle43:23:50.121 99.4%251381 0.000 621.487600057.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:15:47.967 0.6%504803 0.000 1.878104372.111
readart00:00:01.137 0.0%456 0.000 2.493 247.000
TOTAL: 43:40:29.04543:39:39.381100.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
nl-admin@nic.surfnet.nl000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 777 16904041685461 241 4702 99%282:09:01
2news.task.gda.pl 16 29414 5911 21997 1506 20%37:08:58
3news.nask.pl 4 17871 4029 13141 701 22%22:33:48
4localhost 9 8 8 0 0 100%00:00:02
5news.icm.edu.pl 43 237 7 226 4 2%17:16:42
TOTAL: 5 849 17379341695416 35605 6913 97%359:08:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl551.7 GB36.2 MB153.4 MB551.9 GB 99%342.4 KB
2news.nask.pl21.0 MB2.4 MB2.5 MB25.9 MB 81%5.6 KB
3news.task.gda.pl12.6 MB49.9 KB4.8 MB17.4 MB 72%2.4 KB
4news.icm.edu.pl236.1 KB0.0 KB96.5 KB332.6 KB 70%30.2 KB
5localhost12.8 KB0.0 KB0.0 KB12.8 KB100%1.6 KB
TOTAL: 5551.8 GB38.6 MB160.7 MB551.9 GB 99%340.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 21 04:15:04 - 04:59:59 64391 3.8% 23.8823.6 GB 4.3%9172.84
Feb 21 05:00:00 - 05:59:59 83573 4.9% 23.2130.5 GB 5.5%8897.98
Feb 21 06:00:00 - 06:59:59 80804 4.8% 22.4530.1 GB 5.5%8773.85
Feb 21 07:00:00 - 07:59:59 83845 4.9% 23.2931.8 GB 5.8%9254.61
Feb 21 08:00:00 - 08:59:59 88361 5.2% 24.5431.6 GB 5.7%9206.51
Feb 21 09:00:00 - 09:59:59 103118 6.1% 28.6431.4 GB 5.7%9132.96
Feb 21 10:00:00 - 10:59:59 109436 6.4% 30.4032.6 GB 5.9%9484.76
Feb 21 11:00:00 - 11:59:59 105591 6.2% 29.3331.6 GB 5.7%9213.26
Feb 21 12:00:00 - 12:59:59 58712 3.5% 16.3118.9 GB 3.4%5516.77
Feb 21 13:00:00 - 13:59:59 46749 2.8% 12.9915.4 GB 2.8%4474.42
Feb 21 14:00:00 - 14:59:59 45953 2.7% 12.7614.1 GB 2.6%4101.53
Feb 21 15:00:00 - 15:59:59 52710 3.1% 14.6418.6 GB 3.4%5413.42
Feb 21 16:00:00 - 16:59:59 48384 2.9% 13.4414.8 GB 2.7%4297.41
Feb 21 17:00:00 - 17:59:59 50921 3.0% 14.1415.7 GB 2.8%4559.20
Feb 21 18:00:00 - 18:59:59 52076 3.1% 14.4715.8 GB 2.9%4605.83
Feb 21 19:00:00 - 19:59:59 50832 3.0% 14.1215.1 GB 2.7%4395.36
Feb 21 20:00:00 - 20:59:59 48267 2.8% 13.4114.6 GB 2.6%4256.58
Feb 21 21:00:00 - 21:59:59 42042 2.5% 11.6813.1 GB 2.4%3814.51
Feb 21 22:00:00 - 22:59:59 43713 2.6% 12.1414.3 GB 2.6%4162.33
Feb 21 23:00:00 - 23:59:59 44983 2.7% 12.5014.3 GB 2.6%4176.92
Feb 22 00:00:00 - 00:59:59 82992 4.9% 23.0526.9 GB 4.9%7844.85
Feb 22 01:00:00 - 01:59:59 82326 4.9% 22.8725.9 GB 4.7%7536.89
Feb 22 02:00:00 - 02:59:59 100937 5.9% 28.0431.7 GB 5.8%9244.60
Feb 22 03:00:00 - 03:59:59 100085 5.9% 27.8031.6 GB 5.7%9191.01
Feb 22 04:00:00 - 04:15:02 25967 1.5% 28.798.0 GB 1.4%9287.08
TOTAL: 23:59:58 1696768 100.0% 19.64551.9 GB 100.0%6698.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4863 210 0 3561 0 0 0 0 1092
2news.task.gda.pl 1579 1354 0 32 0 0 0 0 193
3news.nask.pl 756 8 0 727 0 0 0 0 21
4news.icm.edu.pl 7 0 0 0 0 0 0 0 7
TOTAL: 4 7205 1572 0 4320 0 0 0 0 1313

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 274
mailing.freebsd.svn-ports-head 272
uk.railway 98
mailing.gcc.gcc-cvs 61
mozilla.dev.tree-management 60
mailing.freebsd.svn-src-all 47
fa.freebsd.cvs-all 44
mailing.freebsd.ports-bugs 41
alt.windows7.general 39
mailing.freebsd.ports 31
mailing.freebsd.current 30
24hoursupport.helpdesk 28
mailing.freebsd.svn-src-head 28
mailing.openbsd.source-changes 27
mailing.openbsd.misc 27
mozilla.dev.gaia 24
gmane.comp.handhelds.openmoko.community 24
mozilla.dev.platform 22
mailing.unix.samba 22
mailing.postfix.users 22
TOTAL: 78 1572

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 779
EMP (fsl) 165
Attached HTML file 138
EMP (md5) 20
HTML post 18
Scoring filter (8) 4
Scoring filter (10) 2
TOTAL: 7 1126

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 61725 10091 28668 2353 7 151 16%23:50:25
2panorama 43831 2135 39189 339 0 0 4%23:54:24
3task 1953 72 1008 10 0 5 3%21:35:19
4nask 24547 34 15143 0 0 36 0%23:50:31
5poznan 11987 23 10183 11 0 0 0%23:50:03
6okapi 0 0 0 0 0 2561 0%24:00:00
TOTAL: 6 144043 12355 94191 2713 7 2753 8%141:00:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm607.2 MB61.3 MB668.6 MB8.0 KB/s55.0 KB23:50:25
2panorama11.0 MB1.4 MB12.4 MB0.1 KB/s5.1 KB23:54:24
3nask208.4 KB0.0 KB208.4 KB0.0 KB/s6.1 KB23:50:31
4task168.0 KB31.0 KB199.1 KB0.0 KB/s2.4 KB21:35:19
5poznan50.4 KB18.9 KB69.3 KB0.0 KB/s2.0 KB23:50:03
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 6618.6 MB62.8 MB681.4 MB1.4 KB/s46.3 KB141:00:42
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 287 353499.2 KB 287 0 000:00:11
2web.man.lodz.pl 288 5454.1 KB 26 0 000:00:53
3lze200.lze.lodz.pl 3 2850.6 KB 4 0 000:51:14
4212.191.78.190 163 1221.6 KB 4 0 026:21:16
5ip-176.105.135.22.tvsat364.lodz.pl 10 614.2 KB 2 0 003:33:15
6router2.cbmm.lodz.pl 3 34.3 KB 2 0 000:01:12
7isvcs01.man.lodz.pl 8 00.0 KB 0 8 000:00:01
TOTAL: 7 762 456643.9 KB 325 8 043:40:28

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 287 353499.2 KB 287 0 000:00:11
2*.man.lodz.pl 680 5454.1 KB 26 8 000:01:01
3*.lze.lodz.pl 3 2850.6 KB 4 0 000:51:14
4unresolved 165 1221.6 KB 4 0 026:21:47
5*.105.135.22.tvsat364.lodz.pl 10 614.2 KB 2 0 003:33:15
6*.cbmm.lodz.pl 3 34.3 KB 2 0 000:01:12
7*.pa.nsw.optusnet.com.au 8 00.0 KB 0 0 000:00:14
8*.wroclaw.mm.pl 4 00.0 KB 0 0 000:35:14
9*.191.14.62.static.jazztel.es 11 00.0 KB 0 0 012:15:56
10*.toya.net.pl 78 00.0 KB 0 0 000:00:20
TOTAL: 101249 456643.9 KB 325 8 043:40:28

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.464 1.876 0.00026:21:16
154.191.14.62.static.jazztel.es 13.732 18.912 0.00012:15:56
ip-176.105.135.22.tvsat364.lodz.pl 0.028 0.080 0.00003:33:15
lze200.lze.lodz.pl 0.020 0.056 0.00000:51:14
host-89-231-50-15.wroclaw.mm.pl 0.012 0.028 0.00000:35:14
router2.cbmm.lodz.pl 0.008 0.032 0.00000:01:12
web.man.lodz.pl 0.704 2.984 0.00000:00:53
83.14.244.42 0.000 0.032 0.00000:00:31
staticline41435.toya.net.pl 0.180 0.792 0.00000:00:20
pa49-181-247-124.pa.nsw.optusnet.com.au 0.032 0.048 0.00000:00:14
vegas.cm.p.lodz.pl 0.552 2.712 0.00000:00:11
mon.man.lodz.pl 0.676 2.968 0.00000:00:05
david.man.lodz.pl 0.176 0.916 0.00000:00:01
isvcs01.man.lodz.pl 0.040 0.076 0.00000:00:01
? 0.000 0.016 0.00000:00:00
TOTAL: 15 16.624 31.528 0.00043:40:28

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 78
154.191.14.62.static.jazztel.es 11
pa49-181-247-124.pa.nsw.optusnet.com.au 8
host-89-231-50-15.wroclaw.mm.pl 4
83.14.244.42 2
TOTAL: 7 487

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
ip-176.105.135.22.tvsat364.lodz.pl 5 0
212.191.78.190 2 1
154.191.14.62.static.jazztel.es 1 1
lze200.lze.lodz.pl 1 0
TOTAL: 4 9 2

Newsgroup request counts (by category):

CategoryCountPct
1lodman 353 77.4%
2pl 103 22.6%
TOTAL: 2 456100.0%

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

NewsgroupCount
1lodman.info 353
2pl.comp.pecet 40
3pl.comp.os.ms-windows.winnt 18
4pl.misc.telefonia.gsm 14
5pl.rec.kuchnia 10
6pl.misc.kolej 5
7pl.soc.dzieci.starsze 5
8pl.rec.rowery 3
9pl.rec.gory 2
10pl.comp.os.linux 2
11pl.regionalne.lodz 2
12pl.soc.prawo 1
13pl.sci.chemia 1
TOTAL: 13 456