Daily Usenet report

Apr 1 04:15:01 -- Apr 2 04:15:01

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Apr 1 06:30:03 newsfeed pgpverify[5409]: pgpverify: verification failed
Apr 1 06:30:03 newsfeed pgpverify[5417]: pgpverify: verification failed
Apr 1 06:30:03 newsfeed pgpverify[5425]: pgpverify: verification failed
Apr 1 06:30:03 newsfeed pgpverify[5433]: pgpverify: verification failed
Apr 1 12:36:33 newsfeed nnrpd[30004]: SERVER perl filter not defined
Apr 1 12:57:11 newsfeed overchan[17156]: input line too long, skipping
Apr 1 13:13:59 newsfeed overchan[17156]: input line too long, skipping
Apr 1 16:01:18 newsfeed overchan[17156]: input line too long, skipping
Apr 1 16:02:08 newsfeed overchan[17156]: input line too long, skipping
Apr 1 16:48:43 newsfeed overchan[17156]: input line too long, skipping
Apr 1 17:02:29 newsfeed overchan[17156]: input line too long, skipping
Apr 1 17:12:41 newsfeed overchan[17156]: input line too long, skipping
Apr 1 17:18:01 newsfeed overchan[17156]: input line too long, skipping
Apr 1 20:19:22 newsfeed overchan[17156]: input line too long, skipping
Apr 1 22:30:02 newsfeed pgpverify[21795]: pgpverify: verification failed
Apr 1 22:39:42 newsfeed overchan[17156]: input line too long, skipping
Apr 2 01:09:38 newsfeed overchan[17156]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 532653 89.9%58.8 MB 88.9%
innfeed 47308 8.0%5.6 MB 8.5%
innd 9187 1.6%1.4 MB 2.1%
nnrpd 3362 0.6%315.1 KB 0.5%
controlchan 16 0.0%2.7 KB 0.0%
overchan 12 0.0%2.1 KB 0.0%
pgpverify 5 0.0%0.6 KB 0.0%
TOTAL: 7 592543 100.0%66.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 529997 98.8%
Negative hits 5852 1.1%
Positive hits 294 0.1%
Cache misses 37 0.0%
TOTAL: 4 536180 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.831 0.0%90 0.000 20.344 120.000
article cleanup00:00:02.094 0.0%532260 0.001 0.004 0.009
article logging00:00:13.395 0.0%532644 0.010 0.025 1.211
article parse00:09:09.160 0.6%119175174 0.003 0.005 0.008
article write00:04:11.564 0.3%532047 0.217 0.473 6.184
artlog/artcncl00:00:00.002 0.0%89 0.000 0.022 0.500
data move00:00:21.025 0.0%123635544 0.000 0.000 0.001
hisgrep/artcncl00:00:00.513 0.0%86 0.000 5.965 36.000
hishave/artcncl00:00:00.038 0.0%90 0.000 0.422 6.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:24:13.036 1.7%538406 0.180 2.699 37.883
history sync00:00:00.008 0.0%290 0.000 0.028 0.500
history write01:14:44.350 5.2%532245 1.419 8.425 68.916
hiswrite/artcncl00:00:00.012 0.0%4 0.000 3.000 9.000
idle21:19:06.343 88.8%118887101 0.260 0.646 1.014
nntp read00:12:24.824 0.9%118918828 0.005 0.006 0.009
overview write00:00:01.167 0.0%532047 0.000 0.002 0.004
perl filter00:28:21.338 2.0%532245 2.361 3.197 4.336
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:09.001 0.0%1076771 0.006 0.008 0.012
TOTAL: 24:00:12.76223:52:59.701 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.036 0.0%48658 0.000 0.001 0.006
article prepare00:00:00.000 0.0%6986 0.000 0.000 0.000
article read00:00:52.489 0.1%1738 0.000 30.201 1585.500
backlog stats00:00:00.048 0.0%122423 0.000 0.000 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:00.287 0.0%57439 0.000 0.005 0.033
data write00:00:00.757 0.0%46331 0.000 0.016 0.044
idle23:39:39.273 98.9%122423 278.906 695.778 1255.481
status file00:14:08.063 1.0%16666 0.356 50.886 1511.981
TOTAL: 23:54:43.32123:54:40.953100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:21.104 76.4%2776 0.000 7.602 10047.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.047 0.2%5944 0.000 0.008 0.500
readart00:00:00.000 0.0%48 0.000 0.000 0.000
TOTAL: 00:00:27.64000:00:21.151 76.5%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001501
TOTAL001501

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 338 532310 532142 0 168 99%108:44:52
2news.icm.edu.pl 47 292 16 231 45 5%17:59:50
3localhost 1442 1 1 0 0 100%00:00:00
TOTAL: 3 1827 532603 532159 231 213 99%126:44:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl259.1 GB518.7 KB915.7 KB259.1 GB 99%510.3 KB
2news.icm.edu.pl463.8 KB0.0 KB1.4 MB1.9 MB 24%31.4 KB
3localhost1.4 KB0.0 KB0.0 KB1.4 KB100%1.4 KB
TOTAL: 3259.1 GB518.7 KB2.3 MB259.1 GB 99%510.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 1 04:15:01 - 04:59:59 15958 3.0% 5.918.3 GB 3.2%3238.88
Apr 1 05:00:00 - 05:59:59 18875 3.5% 5.2410.1 GB 3.9%2933.66
Apr 1 06:00:00 - 06:59:59 20341 3.8% 5.6511.0 GB 4.3%3217.55
Apr 1 07:00:00 - 07:59:59 19417 3.7% 5.3910.5 GB 4.1%3071.28
Apr 1 08:00:00 - 08:59:59 20979 3.9% 5.8311.1 GB 4.3%3224.25
Apr 1 09:00:00 - 09:59:59 24455 4.6% 6.7911.6 GB 4.5%3386.93
Apr 1 10:00:00 - 10:59:59 22730 4.3% 6.3111.3 GB 4.4%3300.10
Apr 1 11:00:00 - 11:59:59 22723 4.3% 6.3111.2 GB 4.3%3248.91
Apr 1 12:00:00 - 12:59:59 21639 4.1% 6.0110.4 GB 4.0%3019.48
Apr 1 13:00:00 - 13:59:59 23170 4.4% 6.4411.0 GB 4.2%3204.87
Apr 1 14:00:00 - 14:59:59 23487 4.4% 6.5211.0 GB 4.2%3189.73
Apr 1 15:00:00 - 15:59:59 26144 4.9% 7.2611.5 GB 4.4%3363.95
Apr 1 16:00:00 - 16:59:59 26182 4.9% 7.2711.9 GB 4.6%3471.97
Apr 1 17:00:00 - 17:59:59 24054 4.5% 6.6810.9 GB 4.2%3163.30
Apr 1 18:00:00 - 18:59:59 23977 4.5% 6.6611.3 GB 4.3%3279.58
Apr 1 19:00:00 - 19:59:59 23960 4.5% 6.6610.9 GB 4.2%3183.37
Apr 1 20:00:00 - 20:59:59 24475 4.6% 6.8010.5 GB 4.0%3049.08
Apr 1 21:00:00 - 21:59:59 22483 4.2% 6.2510.6 GB 4.1%3088.41
Apr 1 22:00:00 - 22:59:59 21076 4.0% 5.8510.2 GB 3.9%2973.25
Apr 1 23:00:00 - 23:59:59 20460 3.8% 5.6810.5 GB 4.1%3063.43
Apr 2 00:00:00 - 00:59:59 20723 3.9% 5.7610.3 GB 4.0%3001.37
Apr 2 01:00:00 - 01:59:59 19156 3.6% 5.329.8 GB 3.8%2864.53
Apr 2 02:00:00 - 02:59:59 22239 4.2% 6.1811.5 GB 4.4%3343.81
Apr 2 03:00:00 - 03:59:59 18542 3.5% 5.159.8 GB 3.8%2861.14
Apr 2 04:00:00 - 04:15:01 4723 0.9% 5.242.3 GB 0.9%2658.34
TOTAL: 24:00:00 531968 100.0% 6.16259.5 GB 100.0%3149.90
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 551 149 0 15 4 0 0 0 383
2news.icm.edu.pl 45 0 0 0 0 0 0 0 45
TOTAL: 2 596 149 0 15 4 0 0 0 428

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 93
it.tlc.cellulari.android 22
comp.mobile.android 15
alt.comp.software.seamonkey 13
it.discussioni.energia 2
alt.comp.software.firefox 2
it.comp.os.win.windows7 1
it.tlc.cellulari.iphone 1
TOTAL: 8 149

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

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 29
Too many newsgroups 8
Binary in non-binary group 8
TOTAL: 3 45

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 383
TOTAL: 1 383
TOTAL: 1 383

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 22464 519 11513 259 0 0 2%24:08:50
2panorama 38958 395 10825 134 3 37484 1%24:00:01
3nask 0 0 0 0 0 8440 0%23:57:57
4poznan 19 0 14 0 0 0 0%01:45:02
5okapi 0 0 0 0 0 799 0%23:57:57
TOTAL: 5 61441 914 22352 393 3 46723 1%97:49:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.9 MB157.1 MB159.0 MB1.9 KB/s209.3 KB24:08:50
2panorama1.1 MB515.3 KB1.7 MB0.0 KB/s3.2 KB24:00:01
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:57
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:45:02
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:57
TOTAL: 53.1 MB157.6 MB160.7 MB0.5 KB/s125.9 KB97:49:47
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 292 4853.4 KB 22 0 000:00:14
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 293 4853.4 KB 22 1 000:00:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 293 4853.4 KB 22 1 000:00:14
2unresolved 102 00.0 KB 0 0 000:00:13
TOTAL: 2 395 4853.4 KB 22 1 000:00:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.763 1.256 0.00000:00:14
104.152.52.196 0.002 0.002 0.00000:00:10
80.111.142.213 0.008 0.016 0.00000:00:01
212.51.192.185 0.239 0.444 0.00000:00:00
isvcs01.man.lodz.pl 0.004 0.008 0.00000:00:00
45.227.255.71 0.000 0.004 0.00000:00:00
TOTAL: 6 1.016 1.730 0.00000:00:27

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
45.227.255.71 1
104.152.52.196 1
TOTAL: 4 102

NNRP unrecognized commands (by host):

SystemConn
45.227.255.71 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
#003 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.255.71 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 48100.0%
TOTAL: 1 48100.0%

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

NewsgroupCount
1pl.comp.pecet 32
2pl.comp.os.ms-windows.winnt 16
TOTAL: 2 48