Daily Usenet report

Mar 30 04:15:02 -- Mar 31 04:15:02

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Mar 30 12:21:19 newsfeed nnrpd[10155]: SERVER perl filter not defined
Mar 30 12:32:32 newsfeed nnrpd[11979]: SERVER perl filter not defined
Mar 30 12:45:46 newsfeed nnrpd[13833]: SERVER perl filter not defined
Mar 30 12:46:14 newsfeed nnrpd[13932]: SERVER perl filter not defined
Mar 30 12:53:56 newsfeed nnrpd[15182]: SERVER perl filter not defined
Mar 30 15:29:25 newsfeed overchan[1135]: input line too long, skipping
Mar 30 16:25:38 newsfeed overchan[1135]: input line too long, skipping
Mar 30 16:31:48 newsfeed overchan[1135]: input line too long, skipping
Mar 30 16:36:38 newsfeed overchan[1135]: input line too long, skipping
Mar 30 17:03:23 newsfeed overchan[1135]: input line too long, skipping
Mar 30 17:10:54 newsfeed overchan[1135]: input line too long, skipping
Mar 30 17:12:14 newsfeed overchan[1135]: input line too long, skipping
Mar 30 20:06:42 newsfeed overchan[1135]: input line too long, skipping
Mar 30 20:11:52 newsfeed overchan[1135]: input line too long, skipping
Mar 30 22:00:03 newsfeed pgpverify[3539]: pgpverify: verification failed
Mar 30 22:00:03 newsfeed pgpverify[3547]: pgpverify: verification failed
Mar 30 22:01:04 newsfeed pgpverify[3664]: pgpverify: verification failed
Mar 30 22:01:05 newsfeed pgpverify[3672]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 539957 90.1%59.3 MB 89.2%
innfeed 47406 7.9%5.6 MB 8.4%
innd 8281 1.4%1.3 MB 1.9%
nnrpd 3327 0.6%312.6 KB 0.5%
overchan 11 0.0%1.7 KB 0.0%
controlchan 6 0.0%0.4 KB 0.0%
pgpverify 4 0.0%0.6 KB 0.0%
TOTAL: 7 598992 100.0%66.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 535961 99.7%
Negative hits 1227 0.2%
Positive hits 219 0.0%
Cache misses 34 0.0%
TOTAL: 4 537441 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.553 0.0%65 0.000 23.892 146.000
article cleanup00:00:02.872 0.0%538968 0.002 0.005 0.010
article logging00:00:10.425 0.0%539226 0.013 0.019 0.029
article parse00:06:33.784 0.5%101791730 0.003 0.004 0.006
article write00:02:42.771 0.2%538827 0.170 0.302 0.624
artlog/artcncl00:00:00.000 0.0%65 0.000 0.000 0.000
data move00:00:19.925 0.0%106070227 0.000 0.000 0.000
hisgrep/artcncl00:00:00.325 0.0%64 0.000 5.078 15.500
hishave/artcncl00:00:00.096 0.0%65 0.000 1.477 10.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:23:04.123 1.6%540377 0.184 2.561 10.034
history sync00:00:00.008 0.0%291 0.000 0.027 0.500
history write00:39:38.068 2.8%538961 0.598 4.412 11.926
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle22:08:44.169 92.3%101780519 0.554 0.783 1.188
nntp read00:11:11.512 0.8%101565461 0.005 0.007 0.009
overview write00:00:01.202 0.0%538827 0.001 0.002 0.005
perl filter00:21:44.443 1.5%538961 1.903 2.420 3.242
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:09.492 0.0%1089742 0.006 0.009 0.012
TOTAL: 24:00:10.04423:54:24.768 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.043 0.0%48080 0.000 0.001 0.009
article prepare00:00:00.000 0.0%7272 0.000 0.000 0.000
article read00:00:10.908 0.0%1817 0.000 6.003 66.500
backlog stats00:00:00.059 0.0%117096 0.000 0.001 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.329 0.0%55522 0.000 0.006 0.045
data write00:00:00.891 0.0%43772 0.000 0.020 0.054
idle23:52:35.593 99.9%117096 310.315 734.061 1195.388
status file00:01:09.226 0.1%17002 0.250 4.072 323.418
TOTAL: 23:53:59.85523:53:57.049100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:05.694 27.9%2768 0.000 2.057 191.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.047 0.2%5866 0.000 0.008 0.500
readart00:00:00.003 0.0%32 0.000 0.094 1.500
TOTAL: 00:00:20.42800:00:05.744 28.1%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 150
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 195

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000400
TOTAL000400

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 97 539138 539019 0 119 99%58:36:10
2news.icm.edu.pl 50 208 13 174 21 6%14:30:41
3localhost 1446 5 5 0 0 100%00:00:00
TOTAL: 3 1593 539351 539037 174 140 99%73:06:51
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl238.0 GB366.8 KB732.6 KB238.0 GB 99%462.9 KB
2news.icm.edu.pl459.8 KB0.0 KB382.4 KB842.2 KB 54%24.8 KB
3localhost7.4 KB0.0 KB0.0 KB7.4 KB100%1.5 KB
TOTAL: 3238.0 GB366.8 KB1.1 MB238.0 GB 99%462.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 30 04:15:02 - 04:59:59 28941 5.4% 10.737.7 GB 3.2%2973.92
Mar 30 05:00:00 - 05:59:59 26431 4.9% 7.3410.0 GB 4.2%2910.33
Mar 30 06:00:00 - 06:59:59 19365 3.6% 5.389.6 GB 4.0%2809.92
Mar 30 07:00:00 - 07:59:59 19284 3.6% 5.369.6 GB 4.0%2782.62
Mar 30 08:00:00 - 08:59:59 19834 3.7% 5.519.8 GB 4.1%2851.23
Mar 30 09:00:00 - 09:59:59 22389 4.2% 6.2210.3 GB 4.3%3012.09
Mar 30 10:00:00 - 10:59:59 23637 4.4% 6.5710.8 GB 4.5%3135.42
Mar 30 11:00:00 - 11:59:59 22341 4.1% 6.2110.2 GB 4.3%2958.56
Mar 30 12:00:00 - 12:59:59 20056 3.7% 5.579.6 GB 4.0%2786.06
Mar 30 13:00:00 - 13:59:59 24550 4.6% 6.8210.0 GB 4.2%2902.02
Mar 30 14:00:00 - 14:59:59 19111 3.5% 5.319.1 GB 3.8%2643.65
Mar 30 15:00:00 - 15:59:59 25610 4.7% 7.1110.0 GB 4.2%2905.58
Mar 30 16:00:00 - 16:59:59 21038 3.9% 5.849.5 GB 4.0%2765.76
Mar 30 17:00:00 - 17:59:59 19988 3.7% 5.559.6 GB 4.0%2786.05
Mar 30 18:00:00 - 18:59:59 21177 3.9% 5.889.8 GB 4.1%2864.97
Mar 30 19:00:00 - 19:59:59 19611 3.6% 5.459.0 GB 3.8%2627.87
Mar 30 20:00:00 - 20:59:59 23702 4.4% 6.5810.3 GB 4.3%2991.19
Mar 30 21:00:00 - 21:59:59 27046 5.0% 7.5110.0 GB 4.2%2900.12
Mar 30 22:00:00 - 22:59:59 22844 4.2% 6.359.8 GB 4.1%2860.30
Mar 30 23:00:00 - 23:59:59 21360 4.0% 5.939.6 GB 4.0%2790.42
Mar 31 00:00:00 - 00:59:59 22222 4.1% 6.1710.7 GB 4.5%3116.86
Mar 31 01:00:00 - 01:59:59 20856 3.9% 5.799.8 GB 4.1%2864.92
Mar 31 02:00:00 - 02:59:59 21732 4.0% 6.0410.8 GB 4.5%3136.95
Mar 31 03:00:00 - 03:59:59 19788 3.7% 5.5010.0 GB 4.2%2925.98
Mar 31 04:00:00 - 04:15:02 6580 1.2% 7.292.9 GB 1.2%3324.86
TOTAL: 24:00:00 539493 100.0% 6.24238.2 GB 100.0%2891.28
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 376 108 0 7 4 0 0 0 257
2news.icm.edu.pl 23 0 0 0 0 0 0 0 23
TOTAL: 2 399 108 0 7 4 0 0 0 280

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 78
it.tlc.cellulari.android 10
de.rec.sf.startrek 10
comp.mobile.android 6
comp.sys.raspberry-pi 3
it.discussioni.energia 1
TOTAL: 6 108

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

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 14
Binary in non-binary group 7
EMP (md5) 1
TOTAL: 3 22

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 257
news.icm.edu.pl 1
TOTAL: 2 258
TOTAL: 1 258

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 20977 899 10740 86 0 0 4%23:55:23
2panorama 38849 292 10328 104 0 37586 0%23:59:24
3nask 0 0 0 0 0 8091 0%24:01:46
4okapi 0 0 0 0 0 910 0%24:01:47
5poznan 14 0 11 0 0 0 0%01:21:35
TOTAL: 5 59840 1191 21079 190 0 46587 1%97:19:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm3.3 MB5.9 MB9.2 MB0.1 KB/s9.6 KB23:55:23
2panorama829.2 KB407.4 KB1.2 MB0.0 KB/s3.1 KB23:59:24
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:01:46
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:01:47
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:21:35
TOTAL: 54.1 MB6.3 MB10.4 MB0.0 KB/s7.7 KB97:19:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 286 3228.6 KB 12 0 000:00:14
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 291 3228.6 KB 12 5 000:00:20

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 291 3228.6 KB 12 5 000:00:15
2unresolved 101 00.0 KB 0 0 000:00:05
TOTAL: 2 392 3228.6 KB 12 5 000:00:20

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.679 0.952 0.00000:00:14
80.111.142.213 0.005 0.018 0.00000:00:02
185.156.72.10 0.016 0.000 0.00000:00:02
212.51.192.185 0.207 0.312 0.00000:00:00
isvcs01.man.lodz.pl 0.005 0.040 0.00000:00:00
TOTAL: 5 0.912 1.322 0.00000:00:20

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 95
80.111.142.213 4
185.156.72.10 2
TOTAL: 3 101

NNRP unrecognized commands (by host):

SystemConn
185.156.72.10 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
#003 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
185.156.72.10 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 32100.0%
TOTAL: 1 32100.0%

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

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