Daily Usenet report

Jul 9 04:15:04 -- Jul 10 04:15:04

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Jul 9 13:48:49 newsfeed innfeed[2488]: task:0 connect: Network is unreachable
Jul 9 13:48:49 newsfeed innfeed[2488]: nask:0 connect: Network is unreachable
Jul 9 13:48:49 newsfeed innfeed[2488]: icm:0 connect: Network is unreachable
Jul 9 14:31:15 newsfeed pgpverify[4102]: pgpverify: verification failed
Jul 10 04:15:03 newsfeed nnrpd[30264]: web.man.lodz.pl rejected Flushing log and syslog files
Jul 10 04:15:03 newsfeed nnrpd[30265]: web.man.lodz.pl rejected Flushing log and syslog files
Jul 10 04:15:03 newsfeed nnrpd[30266]: web.man.lodz.pl rejected Flushing log and syslog files
Jul 10 04:15:03 newsfeed nnrpd[30267]: web.man.lodz.pl rejected Flushing log and syslog files
Jul 10 04:15:03 newsfeed nnrpd[30268]: web.man.lodz.pl rejected Flushing log and syslog files
Jul 10 04:15:03 newsfeed nnrpd[30270]: web.man.lodz.pl rejected Flushing log and syslog files
Jul 10 04:15:03 newsfeed nnrpd[30271]: web.man.lodz.pl rejected Flushing log and syslog files

Log entries by program:

Program nameLines%LinesSize%Size
inn2176345 98.4%245.6 MB 98.0%
innd 18144 0.8%3.0 MB 1.2%
nnrpd 10008 0.5%1.0 MB 0.4%
innfeed 7180 0.3%1.1 MB 0.4%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 62211682 100.0%250.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2171037 93.9%
Negative hits 94270 4.1%
Positive hits 46505 2.0%
Cache misses 498 0.0%
TOTAL: 4 2312310 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:02:23.977 0.2%8196 0.000 17.567 280.000
article cleanup00:00:28.517 0.0%2166758 0.004 0.013 0.027
article logging00:00:53.812 0.1%2166906 0.008 0.025 0.315
article parse01:12:11.163 5.0%94894925 0.019 0.046 0.089
article write00:23:18.452 1.6%2160712 0.366 0.647 2.654
artlog/artcncl00:00:00.158 0.0%8165 0.000 0.019 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:19.768 0.2%108245498 0.001 0.002 0.007
hisgrep/artcncl00:00:01.674 0.0%277 0.000 6.043 150.000
hishave/artcncl00:01:03.239 0.1%8196 0.000 7.716 261.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:44:39.263 11.4%2304607 0.314 4.287 14.436
history sync00:00:00.009 0.0%289 0.000 0.031 1.000
history write03:52:25.237 16.2%2163334 1.554 6.446 25.092
hiswrite/artcncl00:01:16.528 0.1%7919 0.000 9.664 258.000
idle08:53:14.869 37.1%61797240 0.147 0.518 20.926
nntp read00:50:43.372 3.5%93244975 0.015 0.033 0.045
overview write00:00:13.010 0.0%2160712 0.000 0.006 0.018
perl filter05:29:31.663 22.9%2163334 6.384 9.139 11.209
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:30.292 0.2%4367859 0.012 0.048 0.071
TOTAL: 23:58:37.41523:39:15.003 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.160 0.0%46510 0.000 0.003 0.143
article prepare00:00:00.027 0.0%86444 0.000 0.000 0.062
article read00:00:05.440 0.0%20628 0.000 0.264 19.945
backlog stats00:00:00.268 0.0%359872 0.000 0.001 0.015
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.300 0.0%207408 0.000 0.011 1.000
data write00:00:07.483 0.0%184180 0.000 0.041 0.500
idle23:58:32.627100.0%359872 0.000 239.843 17083.000
status file00:00:02.062 0.0%298 0.000 6.919 240.500
TOTAL: 23:58:57.68823:58:50.367100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:01.674 0.0%30253 0.055 0.055 0.055
idle51:42:02.946100.0%70859 0.000 2626.666262848.571
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.280 0.0%143929 0.000 0.016 0.556
readart00:00:05.513 0.0%30738 0.000 0.179 37.625
TOTAL: 51:42:47.37451:42:12.413100.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
ffm.admin@arcor.de000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 836 21564922149200 3701 3591 99%403:53:16
2news.nask.pl 3 15651 6807 8290 554 43%22:59:29
3news.task.gda.pl 14 35858 4306 29728 1824 12%43:07:43
4news.icm.edu.pl 43 326 10 297 19 3%19:09:56
5localhost 1 0 0 0 0 0%00:00:00
TOTAL: 5 897 22083272160323 42016 5988 97%489:10:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl748.1 GB13.4 MB27.8 MB748.1 GB 99%364.4 KB
2news.nask.pl22.6 MB1.2 MB1.8 MB25.7 MB 87%3.6 KB
3news.task.gda.pl9.2 MB75.3 KB5.4 MB14.7 MB 62%2.5 KB
4news.icm.edu.pl290.7 KB32.6 KB421.7 KB745.0 KB 39%25.7 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 5748.1 GB14.7 MB35.4 MB748.1 GB 99%362.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 9 04:15:04 - 04:59:59 61341 2.8% 22.7521.6 GB 2.9%8413.07
Jul 9 05:00:00 - 05:59:59 88081 4.1% 24.4727.4 GB 3.7%7982.12
Jul 9 06:00:00 - 06:59:59 97628 4.5% 27.1232.5 GB 4.3%9463.15
Jul 9 07:00:00 - 07:59:59 70028 3.2% 19.4525.8 GB 3.4%7511.29
Jul 9 08:00:00 - 08:59:59 82061 3.8% 22.7929.9 GB 4.0%8700.91
Jul 9 09:00:00 - 09:59:59 74639 3.5% 20.7329.0 GB 3.9%8453.36
Jul 9 10:00:00 - 10:59:59 90440 4.2% 25.1234.6 GB 4.6%10090.89
Jul 9 11:00:00 - 11:59:59 91619 4.2% 25.4535.7 GB 4.8%10401.01
Jul 9 12:00:00 - 12:59:59 100841 4.7% 28.0136.0 GB 4.8%10490.78
Jul 9 13:00:00 - 13:59:59 84879 3.9% 23.5828.5 GB 3.8%8301.76
Jul 9 14:00:00 - 14:59:59 88720 4.1% 24.6430.8 GB 4.1%8956.83
Jul 9 15:00:00 - 15:59:59 111258 5.1% 30.9132.8 GB 4.4%9547.97
Jul 9 16:00:00 - 16:59:59 95066 4.4% 26.4127.7 GB 3.7%8079.17
Jul 9 17:00:00 - 17:59:59 92839 4.3% 25.7934.1 GB 4.6%9928.43
Jul 9 18:00:00 - 18:59:59 91473 4.2% 25.4133.7 GB 4.5%9820.38
Jul 9 19:00:00 - 19:59:59 103130 4.8% 28.6534.7 GB 4.6%10098.61
Jul 9 20:00:00 - 20:59:59 114928 5.3% 31.9234.9 GB 4.7%10151.20
Jul 9 21:00:00 - 21:59:59 95939 4.4% 26.6532.1 GB 4.3%9343.64
Jul 9 22:00:00 - 22:59:59 73572 3.4% 20.4427.1 GB 3.6%7892.03
Jul 9 23:00:00 - 23:59:59 88829 4.1% 24.6732.2 GB 4.3%9385.84
Jul 10 00:00:00 - 00:59:59 79746 3.7% 22.1528.5 GB 3.8%8297.16
Jul 10 01:00:00 - 01:59:59 87313 4.0% 24.2531.2 GB 4.2%9098.76
Jul 10 02:00:00 - 02:59:59 78971 3.7% 21.9427.4 GB 3.7%7972.55
Jul 10 03:00:00 - 03:59:59 93449 4.3% 25.9631.6 GB 4.2%9203.40
Jul 10 04:00:00 - 04:15:04 25196 1.2% 27.878.5 GB 1.1%9897.73
TOTAL: 24:00:00 2161986 100.0% 25.02748.3 GB 100.0%9081.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3691 170 0 2892 2 0 0 0 627
2news.task.gda.pl 1870 1661 0 46 0 0 0 0 163
3news.nask.pl 614 71 0 484 1 0 0 0 58
4news.icm.edu.pl 19 0 0 2 0 0 0 0 17
TOTAL: 4 6194 1902 0 3424 3 0 0 0 865

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 120
mailing.freebsd.svn-ports-head 119
mailing.freebsd.svn-src-all 107
mailing.gcc.gcc-cvs 106
mailing.freebsd.ports-bugs 101
mailing.freebsd.svn-src-head 93
fa.freebsd.cvs-all 77
mailing.freebsd.current 62
mailing.openbsd.ports-changes 59
mailing.database.pgsql-general 58
alt.politics.scorched-earth 46
uk.railway 45
mailing.openbsd.misc 45
mailing.www.horde-bugs 45
mailing.freebsd.ports 43
comp.mobile.ipad 38
mailing.www.horde-general 36
alt.sex.telephones 35
comp.sys.raspberry-pi 33
mozilla.dev.gaia 31
TOTAL: 84 1902

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

GroupsCount
pl.sci.historia 2
pl.sci.matematyka 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 487
EMP (fsl) 122
Attached HTML file 68
EMP (md5) 22
HTML post 11
Scoring filter (8) 5
Scoring filter (9) 2
TOTAL: 7 717

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 62380 4505 28126 11082 2 44 7%23:54:34
2panorama 49248 4432 39837 1322 0 0 8%23:43:27
3poznan 14230 98 11272 43 0 0 0%23:50:00
4task 2111 70 1093 3 0 0 3%21:55:48
5nask 16267 8 11520 1 0 20 0%23:50:31
6okapi 0 0 0 0 0 2499 0%23:50:01
TOTAL: 6 144236 9113 91848 12451 2 2563 6%141:04:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm32.1 MB2.4 GB2.4 GB29.4 KB/s162.4 KB23:54:34
2panorama12.9 MB27.5 MB40.3 MB0.5 KB/s7.2 KB23:43:27
3poznan541.6 KB75.9 KB617.5 KB0.0 KB/s4.4 KB23:50:00
4task147.3 KB4.1 KB151.4 KB0.0 KB/s2.1 KB21:55:48
5nask15.0 KB2.0 KB17.0 KB0.0 KB/s1.9 KB23:50:31
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
TOTAL: 645.7 MB2.4 GB2.5 GB5.1 KB/s119.3 KB141:04:21
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 288 288428.6 KB 288 0 000:00:07
2212.191.78.190 295 73125.1 KB 23 0 047:00:39
3web.man.lodz.pl 294 6458.0 KB 30 0 000:00:21
4lze200.lze.lodz.pl 2 3156.8 KB 5 0 000:09:42
5aamy229.neoplus.adsl.tpnet.pl 1 1612.7 KB 1 0 000:02:27
6ip-176.105.135.22.tvsat364.lodz.pl 3 1219.9 KB 3 0 001:05:20
7router2.cbmm.lodz.pl 2 22.9 KB 1 0 000:12:53
TOTAL: 7 885 486704.1 KB 351 0 051:42:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 288428.6 KB 288 0 000:00:07
2unresolved 297 73125.1 KB 23 0 047:00:50
3*.man.lodz.pl 679 6458.0 KB 30 0 000:09:41
4*.lze.lodz.pl 2 3156.8 KB 5 0 000:09:42
5*.neoplus.adsl.tpnet.pl 2 1612.7 KB 1 0 000:03:38
6*.105.135.22.tvsat364.lodz.pl 3 1219.9 KB 3 0 001:05:20
7*.cbmm.lodz.pl 2 22.9 KB 1 0 000:12:53
8*.mdsnwi.broadband.dynamic.tds.net 1 00.0 KB 0 0 000:00:01
9*.207.15.62.static.jazztel.es 9 00.0 KB 0 0 002:59:51
10*.61.59.220.host.de.colt.net 1 00.0 KB 0 0 000:00:00
11*.adsl.inetia.pl 1 00.0 KB 0 0 000:00:02
12*.toya.net.pl 24 00.0 KB 0 0 000:00:36
TOTAL: 121309 486704.1 KB 351 0 051:42:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 0.688 3.832 0.00047:00:39
64.207.15.62.static.jazztel.es 2.636 6.944 0.00001:32:13
252.207.15.62.static.jazztel.es 1.548 2.144 0.00001:27:37
ip-176.105.135.22.tvsat364.lodz.pl 0.004 0.036 0.00001:05:20
router2.cbmm.lodz.pl 0.004 0.040 0.00000:12:53
lze200.lze.lodz.pl 0.008 0.052 0.00000:09:42
mbox.man.lodz.pl 0.008 0.016 0.00000:09:09
aamy229.neoplus.adsl.tpnet.pl 0.004 0.012 0.00000:02:27
ecf88.neoplus.adsl.tpnet.pl 0.008 0.004 0.00000:01:10
staticline41435.toya.net.pl 0.068 0.224 0.00000:00:36
web.man.lodz.pl 0.564 3.636 0.00000:00:21
212.51.203.199 0.008 0.032 0.00000:00:11
vegas.cm.p.lodz.pl 0.764 3.648 0.00000:00:07
f-oper-v100.man.lodz.pl 0.576 3.788 0.00000:00:07
david.man.lodz.pl 0.276 1.232 0.00000:00:03
159-205-132-74.adsl.inetia.pl 0.000 0.020 0.00000:00:02
h69-129-197-243.mdsnwi.broadband.dynamic.tds.net 0.008 0.012 0.00000:00:01
h-213.61.59.220.host.de.colt.net 0.008 0.008 0.00000:00:00
TOTAL: 18 7.180 25.680 0.00051:42:46

Curious NNRP server explorers [Top 20]:

SystemConn
f-oper-v100.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 24
64.207.15.62.static.jazztel.es 7
252.207.15.62.static.jazztel.es 2
212.51.203.199 2
ecf88.neoplus.adsl.tpnet.pl 1
h69-129-197-243.mdsnwi.broadband.dynamic.tds.net 1
159-205-132-74.adsl.inetia.pl 1
mbox.man.lodz.pl 1
h-213.61.59.220.host.de.colt.net 1
TOTAL: 11 424

NNRP client timeouts [Top 20]:

SystemConnPeer
252.207.15.62.static.jazztel.es 2 0
ip-176.105.135.22.tvsat364.lodz.pl 1 0
TOTAL: 2 3 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 288 59.3%
2pl 181 37.2%
3lodz 16 3.3%
4alt 1 0.2%
TOTAL: 4 486100.0%

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

NewsgroupCount
1lodman.info 288
2pl.comp.pecet 71
3pl.regionalne.lodz 40
4pl.soc.prawo 17
5lodz.test 16
6pl.comp.os.ms-windows.winnt 12
7pl.rec.gory 11
8pl.rec.rowery 11
9pl.regionalne.warszawa 7
10pl.praca.dyskusje 6
11pl.rec.kuchnia 5
12alt.pl.praca.oferowana 1
13pl.comp.os.linux 1
TOTAL: 13 486