Daily Usenet report

Dec 31 04:15:03 -- Jan 1 04:15:02

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Dec 31 07:27:42 newsfeed pgpverify[8445]: pgpverify: verification failed
Dec 31 13:48:07 newsfeed nnrpd[11973]: SERVER perl filter not defined
Dec 31 14:39:15 newsfeed overchan[1539]: input line too long, skipping
Dec 31 15:08:35 newsfeed overchan[1539]: input line too long, skipping
Dec 31 15:15:59 newsfeed nnrpd[14791]: SERVER perl filter not defined
Dec 31 15:17:23 newsfeed nnrpd[14970]: SERVER perl filter not defined
Dec 31 16:13:43 newsfeed nnrpd[16726]: SERVER perl filter not defined
Dec 31 16:20:40 newsfeed overchan[1539]: input line too long, skipping
Dec 31 16:29:45 newsfeed overchan[1539]: input line too long, skipping
Dec 31 16:43:53 newsfeed nnrpd[17723]: SERVER perl filter not defined
Dec 31 16:45:59 newsfeed overchan[1539]: input line too long, skipping
Dec 31 16:49:37 newsfeed nnrpd[17961]: SERVER perl filter not defined
Dec 31 17:54:06 newsfeed overchan[1539]: input line too long, skipping
Dec 31 20:45:12 newsfeed overchan[1539]: input line too long, skipping
Dec 31 20:45:50 newsfeed overchan[1539]: input line too long, skipping
Dec 31 20:50:57 newsfeed overchan[1539]: input line too long, skipping
Dec 31 20:52:12 newsfeed overchan[1539]: input line too long, skipping
Jan 1 01:29:22 newsfeed overchan[1539]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1567178 97.7%185.1 MB 97.5%
innfeed 22022 1.4%2.6 MB 1.4%
innd 10319 0.6%1.7 MB 0.9%
nnrpd 4963 0.3%523.9 KB 0.3%
overchan 12 0.0%2.0 KB 0.0%
controlchan 9 0.0%1.2 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 71604504 100.0%189.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1545737 98.1%
Negative hits 25449 1.6%
Positive hits 4991 0.3%
Cache misses 32 0.0%
TOTAL: 4 1576209 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.134 0.0%37 0.000 57.676 974.000
article cleanup00:00:22.679 0.0%1560720 0.011 0.015 0.020
article logging00:01:16.973 0.1%1561310 0.035 0.049 0.064
article parse00:27:38.443 1.9%70120144 0.015 0.024 0.034
article write00:10:57.783 0.8%1557020 0.183 0.422 0.664
artlog/artcncl00:00:00.003 0.0%34 0.000 0.088 0.200
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:17.048 0.1%79107392 0.001 0.001 0.002
hisgrep/artcncl00:00:00.464 0.0%32 0.000 14.500 33.750
hishave/artcncl00:00:00.774 0.0%37 0.000 20.919 627.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:32:03.957 10.6%1589448 1.757 5.740 12.755
history sync00:00:00.024 0.0%288 0.000 0.083 0.500
history write03:25:42.298 14.4%1558161 3.899 7.921 14.048
hiswrite/artcncl00:00:00.402 0.0%5 0.000 80.400 347.000
idle13:43:27.619 57.6%52516858 0.378 0.941 18.040
nntp read00:45:26.722 3.2%68706574 0.029 0.040 0.057
overview write00:00:08.214 0.0%1557020 0.003 0.005 0.007
perl filter02:25:01.116 10.1%1558161 3.575 5.584 7.408
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:13.831 0.2%3125848 0.040 0.062 0.084
TOTAL: 23:50:05.35823:36:40.484 99.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.089 0.0%31316 0.000 0.003 0.015
article prepare00:00:00.007 0.0%18924 0.000 0.000 0.025
article read00:00:55.371 0.1%4672 2.714 11.852 84.286
backlog stats00:00:00.076 0.0%85473 0.000 0.001 0.006
callbacks00:00:00.000 0.0%5 0.000 0.000 0.000
data read00:00:00.939 0.0%48522 0.000 0.019 0.116
data write00:00:02.233 0.0%36915 0.030 0.060 0.169
idle23:44:11.841 99.9%85473 420.281 999.752 2123.215
status file00:00:07.610 0.0%7480 0.500 1.017 3.526
TOTAL: 23:45:26.44323:45:18.166100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:01:38.834 8.6%15554 0.000 6.354 7.025
idle00:17:17.461 90.2%18688 0.000 55.515 206.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.560 0.1%38102 0.000 0.041 1.316
readart00:00:00.004 0.0%92 0.000 0.043 0.500
TOTAL: 00:19:10.54900:18:57.859 98.9%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
grisbi-control@grisbi.org000100
usenet@film.rlss.okayama-u.ac.jp001011
TOTAL001111

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 137 15571841556380 113 691 99%127:10:58
2news.nask.pl 3 10515 5451 2113 2951 51%23:05:00
3news.icm.edu.pl 48 209 32 159 18 15%15:23:10
4localhost 7 6 6 0 0 100%00:00:00
TOTAL: 4 195 15679141561869 2385 3660 99%165:39:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl457.0 GB12.2 MB12.4 MB457.0 GB 99%307.8 KB
2news.nask.pl22.5 MB7.0 MB17.0 MB46.5 MB 48%5.7 KB
3news.icm.edu.pl583.1 KB22.0 KB278.6 KB883.7 KB 65%17.7 KB
4localhost14.0 KB0.0 KB0.0 KB14.0 KB100%2.3 KB
TOTAL: 4457.0 GB19.2 MB29.7 MB457.0 GB 99%306.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 31 04:15:03 - 04:59:59 54993 3.5% 20.3915.2 GB 3.3%5908.53
Dec 31 05:00:00 - 05:59:59 51033 3.3% 14.1815.9 GB 3.5%4621.62
Dec 31 06:00:00 - 06:59:59 67387 4.3% 18.7218.2 GB 4.0%5297.28
Dec 31 07:00:00 - 07:59:59 74499 4.8% 20.6924.0 GB 5.3%6997.07
Dec 31 08:00:00 - 08:59:59 52226 3.3% 14.5116.9 GB 3.7%4915.75
Dec 31 09:00:00 - 09:59:59 63851 4.1% 17.7420.6 GB 4.5%5995.30
Dec 31 10:00:00 - 10:59:59 94237 6.0% 26.1827.5 GB 6.0%8018.78
Dec 31 11:00:00 - 11:59:59 86181 5.5% 23.9425.1 GB 5.5%7298.99
Dec 31 12:00:00 - 12:59:59 89512 5.7% 24.8625.2 GB 5.5%7332.18
Dec 31 13:00:00 - 13:59:59 55714 3.6% 15.4815.4 GB 3.4%4477.74
Dec 31 14:00:00 - 14:59:59 73600 4.7% 20.4421.8 GB 4.8%6339.18
Dec 31 15:00:00 - 15:59:59 69100 4.4% 19.1920.8 GB 4.5%6050.21
Dec 31 16:00:00 - 16:59:59 70970 4.5% 19.7120.1 GB 4.4%5855.39
Dec 31 17:00:00 - 17:59:59 85795 5.5% 23.8324.8 GB 5.4%7218.19
Dec 31 18:00:00 - 18:59:59 85109 5.4% 23.6426.6 GB 5.8%7757.15
Dec 31 19:00:00 - 19:59:59 61622 3.9% 17.1217.4 GB 3.8%5078.34
Dec 31 20:00:00 - 20:59:59 78151 5.0% 21.7123.1 GB 5.1%6728.41
Dec 31 21:00:00 - 21:59:59 80114 5.1% 22.2523.0 GB 5.0%6685.51
Dec 31 22:00:00 - 22:59:59 74074 4.7% 20.5820.5 GB 4.5%5960.31
Dec 31 23:00:00 - 23:59:59 49294 3.2% 13.6913.9 GB 3.0%4055.97
Jan 1 00:00:00 - 00:59:59 23347 1.5% 6.495.4 GB 1.2%1570.56
Jan 1 01:00:00 - 01:59:59 36508 2.3% 10.1410.8 GB 2.4%3132.93
Jan 1 02:00:00 - 02:59:59 35550 2.3% 9.8811.1 GB 2.4%3228.45
Jan 1 03:00:00 - 03:59:59 40240 2.6% 11.1811.5 GB 2.5%3345.64
Jan 1 04:00:00 - 04:15:02 9729 0.6% 10.792.8 GB 0.6%3212.67
TOTAL: 23:59:59 1562836 100.0% 18.09457.3 GB 100.0%5549.74
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 3025 30 0 1951 1 0 0 0 1043
2newsfeed.pionier.net.pl 1264 53 0 617 1 0 0 0 593
3news.icm.edu.pl 19 0 0 2 0 0 0 0 17
TOTAL: 3 4308 83 0 2570 2 0 0 0 1653

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 32
comp.sys.raspberry-pi 27
comp.mobile.android 16
it.tlc.cellulari.android 6
de.rec.sf.startrek 1
de.comm.software.mailreader 1
TOTAL: 6 83

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 967
Binary in non-binary group 25
Scoring filter (16) 19
EMP (phl) 14
Scoring filter (8) 14
Scoring filter (10) 7
Scoring filter (11) 5
Scoring filter (9) 3
Scoring filter (13) 2
Scoring filter (14) 1
Scoring filter (15) 1
Scoring filter (18) 1
Excessively crossposted test article 1
TOTAL: 13 1060

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 574
news.nask.pl 18
news.icm.edu.pl 1
TOTAL: 3 593
TOTAL: 1 593

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 21628 2711 6135 338 14 22392 12%23:57:27
2icm 12924 26 11704 41 0 0 0%24:08:55
3poznan 5987 18 5637 0 0 0 0%23:58:59
4nask 3986 2 3507 0 0 0 0%24:03:36
5okapi 0 0 0 0 0 899 0%23:46:52
TOTAL: 5 44525 2757 26983 379 14 23291 6%119:55:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama8.1 MB1.1 MB9.2 MB0.1 KB/s3.1 KB23:57:27
2icm1.0 MB14.2 MB15.2 MB0.2 KB/s232.6 KB24:08:55
3poznan116.0 KB0.0 KB116.0 KB0.0 KB/s6.4 KB23:58:59
4nask4.6 KB0.0 KB4.6 KB0.0 KB/s2.3 KB24:03:36
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:46:52
TOTAL: 59.2 MB15.3 MB24.5 MB0.1 KB/s8.0 KB119:55:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 9299.7 KB 39 0 000:00:23
2isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 2 294 9299.7 KB 39 6 000:19:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 582 9299.7 KB 39 6 000:00:27
2unresolved 96 00.0 KB 0 0 000:00:01
3*.dynamic.chello.pl 9 00.0 KB 0 0 000:18:40
TOTAL: 3 687 9299.7 KB 39 6 000:19:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89-67-219-158.dynamic.chello.pl 1.092 3.032 0.00000:18:40
web.man.lodz.pl 1.368 3.752 0.00000:00:23
mon.man.lodz.pl 1.180 2.960 0.00000:00:03
212.51.192.185 0.328 0.840 0.00000:00:01
isvcs01.man.lodz.pl 0.040 0.072 0.00000:00:00
122.228.19.80 0.000 0.032 0.00000:00:00
TOTAL: 6 4.008 10.688 0.00000:19:10

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 95
89-67-219-158.dynamic.chello.pl 9
122.228.19.80 1
TOTAL: 4 393

NNRP unrecognized commands (by host):

SystemConn
122.228.19.80 5
TOTAL: 1 5

NNRP unrecognized commands (by command):

CommandCount
Accept: */* 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
Connection: keep-alive 1
Host: 212.191.2.21:119 1
GET / HTTP/1.1 1
TOTAL: 5 5

Newsgroup request counts (by category):

CategoryCountPct
1pl 92100.0%
TOTAL: 1 92100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 50
2pl.comp.pecet 42
TOTAL: 2 92
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>