Daily Usenet report

Sep 7 04:15:01 -- Sep 8 04:15:01

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Sep 7 10:20:15 newsfeed nnrpd[4735]: SERVER perl filter not defined
Sep 7 10:24:46 newsfeed nnrpd[5375]: SERVER perl filter not defined
Sep 7 10:26:10 newsfeed nnrpd[5715]: SERVER perl filter not defined
Sep 7 11:10:00 newsfeed nnrpd[12188]: SERVER perl filter not defined
Sep 7 11:10:38 newsfeed nnrpd[12381]: SERVER perl filter not defined
Sep 7 11:11:01 newsfeed nnrpd[12384]: SERVER perl filter not defined
Sep 7 12:42:21 newsfeed overchan[14515]: input line too long, skipping
Sep 7 12:53:30 newsfeed nnrpd[27561]: SERVER perl filter not defined
Sep 7 15:22:59 newsfeed nnrpd[18003]: SERVER perl filter not defined
Sep 7 15:23:10 newsfeed nnrpd[18005]: SERVER perl filter not defined
Sep 7 16:45:21 newsfeed overchan[14515]: input line too long, skipping
Sep 7 16:51:05 newsfeed overchan[14515]: input line too long, skipping
Sep 7 20:40:32 newsfeed nnrpd[527]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 460644 89.0%50.9 MB 88.1%
innfeed 45209 8.7%5.3 MB 9.2%
innd 8233 1.6%1.3 MB 2.2%
nnrpd 3445 0.7%323.3 KB 0.5%
overchan 4 0.0%0.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 517536 100.0%57.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 458169 99.0%
Negative hits 4515 1.0%
Positive hits 192 0.0%
Cache misses 33 0.0%
TOTAL: 4 462909 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.722 0.0%81 0.000 21.259 150.000
article cleanup00:00:03.652 0.0%460346 0.004 0.008 0.012
article logging00:00:11.791 0.0%460712 0.016 0.026 0.032
article parse00:06:32.705 0.5%87858156 0.003 0.004 0.006
article write00:03:40.654 0.3%460153 0.271 0.480 2.230
artlog/artcncl00:00:00.001 0.0%80 0.000 0.013 0.091
data move00:00:29.715 0.0%91496280 0.000 0.000 0.000
hisgrep/artcncl00:00:00.320 0.0%72 0.000 4.444 23.333
hishave/artcncl00:00:00.001 0.0%81 0.000 0.012 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:05:21.873 0.4%465124 0.179 0.692 19.635
history sync00:00:00.012 0.0%291 0.000 0.041 0.500
history write00:09:05.837 0.6%460333 0.276 1.186 38.069
hiswrite/artcncl00:00:00.012 0.0%9 0.000 1.333 10.000
idle22:33:57.137 94.0%85273072 0.578 0.953 1.828
nntp read00:19:35.262 1.4%87539345 0.011 0.013 0.017
overview write00:00:01.375 0.0%460153 0.001 0.003 0.006
perl filter00:29:17.426 2.0%460333 2.897 3.818 4.725
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:11.392 0.0%931606 0.008 0.012 0.017
TOTAL: 24:00:00.71823:48:30.887 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.068 0.0%56416 0.000 0.001 0.010
article prepare00:00:00.001 0.0%42886 0.000 0.000 0.000
article read00:00:54.276 0.1%10736 0.000 5.056 369.333
backlog stats00:00:00.058 0.0%112305 0.000 0.001 0.005
callbacks00:00:00.055 0.0%35 0.000 1.571 1.833
data read00:00:00.514 0.0%55847 0.000 0.009 0.032
data write00:00:01.188 0.0%44631 0.000 0.027 0.053
idle23:52:50.533 99.8%112305 33.256 765.509 1730.163
newart/cb00:00:00.000 0.0%1 0.000 0.000 0.000
prepart/cb00:00:00.000 0.0%94 0.000 0.000 0.000
readart/cb00:00:00.055 0.0%24 2.095 2.292 3.667
status file00:02:04.372 0.1%16858 0.322 7.378 565.035
TOTAL: 23:55:54.23123:55:51.120100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:00.144 88.7%3012 0.000 19.968 10021.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.079 0.1%6731 0.000 0.012 0.500
readart00:00:00.732 1.1%208 0.000 3.519 5.014
TOTAL: 00:01:07.77200:01:00.955 89.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 213 460406 460234 0 172 99%104:02:24
2news.icm.edu.pl 20 201 40 140 21 19%09:07:34
3localhost 1451 10 10 0 0 100%00:00:02
TOTAL: 3 1684 460617 460284 140 193 99%113:10:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl223.3 GB1.2 MB1.6 MB223.3 GB 99%508.6 KB
2news.icm.edu.pl3.1 MB0.0 KB330.5 KB3.4 MB 90%56.8 KB
3localhost15.1 KB0.0 KB0.0 KB15.1 KB100%1.5 KB
TOTAL: 3223.3 GB1.2 MB1.9 MB223.3 GB 99%508.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 7 04:15:01 - 04:59:59 9961 2.2% 3.694.7 GB 2.1%1838.77
Sep 7 05:00:00 - 05:59:59 18546 4.0% 5.1510.3 GB 4.6%3013.89
Sep 7 06:00:00 - 06:59:59 19404 4.2% 5.3910.0 GB 4.5%2905.13
Sep 7 07:00:00 - 07:59:59 21082 4.6% 5.8610.8 GB 4.8%3149.61
Sep 7 08:00:00 - 08:59:59 26078 5.7% 7.2413.1 GB 5.9%3808.39
Sep 7 09:00:00 - 09:59:59 23867 5.2% 6.6312.2 GB 5.4%3541.29
Sep 7 10:00:00 - 10:59:59 16455 3.6% 4.577.2 GB 3.2%2099.40
Sep 7 11:00:00 - 11:59:59 16015 3.5% 4.456.4 GB 2.9%1867.53
Sep 7 12:00:00 - 12:59:59 15236 3.3% 4.236.3 GB 2.8%1838.79
Sep 7 13:00:00 - 13:59:59 14556 3.2% 4.046.3 GB 2.8%1835.60
Sep 7 14:00:00 - 14:59:59 14284 3.1% 3.976.4 GB 2.9%1855.11
Sep 7 15:00:00 - 15:59:59 14367 3.1% 3.996.4 GB 2.8%1850.70
Sep 7 16:00:00 - 16:59:59 18355 4.0% 5.109.2 GB 4.1%2687.87
Sep 7 17:00:00 - 17:59:59 17280 3.8% 4.809.2 GB 4.1%2681.10
Sep 7 18:00:00 - 18:59:59 19046 4.1% 5.299.2 GB 4.1%2676.02
Sep 7 19:00:00 - 19:59:59 20352 4.4% 5.6510.1 GB 4.5%2939.85
Sep 7 20:00:00 - 20:59:59 22803 5.0% 6.3310.8 GB 4.8%3149.49
Sep 7 21:00:00 - 21:59:59 21824 4.7% 6.0611.3 GB 5.1%3296.60
Sep 7 22:00:00 - 22:59:59 20866 4.5% 5.809.7 GB 4.4%2837.99
Sep 7 23:00:00 - 23:59:59 23715 5.2% 6.5911.5 GB 5.1%3344.21
Sep 8 00:00:00 - 00:59:59 23064 5.0% 6.4110.6 GB 4.7%3077.68
Sep 8 01:00:00 - 01:59:59 19405 4.2% 5.399.8 GB 4.4%2865.37
Sep 8 02:00:00 - 02:59:59 21551 4.7% 5.9911.3 GB 5.1%3285.86
Sep 8 03:00:00 - 03:59:59 18857 4.1% 5.249.0 GB 4.0%2617.01
Sep 8 04:00:00 - 04:15:01 3034 0.7% 3.371.5 GB 0.7%1802.42
TOTAL: 24:00:00 460003 100.0% 5.32223.3 GB 100.0%2710.59
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 540 155 0 13 4 0 0 0 368
2news.icm.edu.pl 21 0 0 0 1 0 0 0 20
TOTAL: 2 561 155 0 13 5 0 0 0 388

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 81
alt.comp.software.firefox 22
it.tlc.cellulari.android 17
comp.sys.raspberry-pi 9
alt.comp.software.seamonkey 8
it.comp.os.win.windows10 8
comp.mobile.android 6
it.comp.os.linux.ubuntu 2
de.comp.lang.vbclassic 2
TOTAL: 9 155

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

GroupsCount
pl.sci.matematyka 2
pl.praca.oferowana 1
pl.sci.historia 1
soc.culture.pakistan.education 1
TOTAL: 4 5

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 15
Binary in non-binary group 2
EMP (md5) 1
Too many newsgroups (low_xpost) 1
Scoring filter (10) 1
TOTAL: 5 20

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 18605 9142 5018 726 36 5747 49%24:07:47
2panorama 39421 322 11185 117 2 35410 0%24:00:23
3poznan 45 0 40 0 0 0 0%02:04:49
4okapi 0 0 0 0 0 828 0%24:00:19
5nask 0 0 0 0 0 7625 0%23:59:38
TOTAL: 5 58071 9464 16243 843 38 49610 16%98:12:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm34.0 MB40.1 MB74.2 MB0.9 KB/s7.7 KB24:07:47
2panorama949.1 KB684.4 KB1.6 MB0.0 KB/s3.7 KB24:00:23
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:04:49
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:19
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:38
TOTAL: 534.9 MB40.8 MB75.8 MB0.2 KB/s7.5 KB98:12:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1212.90.61.180 1 145212.4 KB 1 0 000:00:21
2web.man.lodz.pl 293 6283.7 KB 28 0 000:00:31
3isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 3 304 207296.1 KB 29 10 000:01:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 102 145212.4 KB 1 0 000:00:34
2*.man.lodz.pl 303 6283.7 KB 28 10 000:00:32
3*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 3 406 207296.1 KB 29 10 000:01:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.828 1.722 0.00000:00:31
212.90.61.180 0.027 0.024 0.00000:00:21
23.129.64.150 0.000 0.007 0.00000:00:10
80.111.142.213 0.021 0.017 0.00000:00:02
isvcs01.man.lodz.pl 0.036 0.069 0.00000:00:00
212.51.192.185 0.252 0.483 0.00000:00:00
scan-141.security.ipip.net 0.004 0.004 0.00000:00:00
TOTAL: 7 1.168 2.326 0.00000:01:07

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
scan-141.security.ipip.net 1
23.129.64.150 1
TOTAL: 4 102

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
Connection: close 1
Host: 212.191.2.21:119 1
User-Agent: HTTP Banner Detection (https... 1
TOTAL: 4 4

Newsgroup request counts (by category):

CategoryCountPct
1lodman 145 70.0%
2pl 62 30.0%
TOTAL: 2 207100.0%

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

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