Daily Usenet report

Sep 9 04:15:02 -- Sep 10 04:15:01

Unknown entries from news log file:

First 21 / 21 lines (100.0%)

Sep 9 08:20:14 newsfeed nnrpd[19721]: SERVER perl filter not defined
Sep 9 08:20:46 newsfeed nnrpd[19722]: SERVER perl filter not defined
Sep 9 08:21:40 newsfeed nnrpd[19723]: SERVER perl filter not defined
Sep 9 08:57:09 newsfeed nnrpd[20944]: SERVER perl filter not defined
Sep 9 09:19:39 newsfeed overchan[10892]: input line too long, skipping
Sep 9 11:00:56 newsfeed overchan[10892]: input line too long, skipping
Sep 9 11:01:11 newsfeed overchan[10892]: input line too long, skipping
Sep 9 11:01:24 newsfeed overchan[10892]: input line too long, skipping
Sep 10 01:43:17 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 01:55:57 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 01:56:23 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 01:56:55 newsfeed innd: message repeated 5 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 01:59:01 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 01:59:33 newsfeed innd: message repeated 4 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 02:00:34 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 02:00:50 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 02:02:18 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 02:04:02 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 02:07:52 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 02:19:24 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 3 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]
Sep 10 02:19:36 newsfeed innd: message repeated 2 times: [ newsfeed.pionier.net.pl:130 checkpoint seconds 4 accepted 200 refused 0 rejected 0 duplicate 0 accepted size 13107200 duplicate size 0 rejected size 0]

Log entries by program:

Program nameLines%LinesSize%Size
inn1961209 96.8%221.5 MB 96.3%
innfeed 50150 2.5%6.0 MB 2.6%
innd 10767 0.5%1.9 MB 0.8%
nnrpd 4896 0.2%531.5 KB 0.2%
overchan 5 0.0%0.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62027028 100.0%229.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1953570 100.0%
Negative hits 650 0.0%
Positive hits 289 0.0%
Cache misses 34 0.0%
TOTAL: 4 1954543 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.826 0.0%159 0.000 5.195 62.000
article cleanup00:00:24.259 0.0%1978612 0.006 0.012 0.018
article logging00:01:15.810 0.1%1979054 0.024 0.038 0.054
article parse00:18:20.210 1.3%37668018 0.015 0.029 0.039
article write00:08:55.312 0.6%1978447 0.108 0.271 0.861
artlog/artcncl00:00:00.003 0.0%159 0.000 0.019 1.000
data move00:00:48.261 0.1%45102621 0.001 0.001 0.002
hisgrep/artcncl00:00:00.331 0.0%136 0.000 2.434 59.000
hishave/artcncl00:00:00.016 0.0%159 0.000 0.101 2.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:12:23.163 0.9%1979430 0.007 0.375 3.571
history sync00:00:00.018 0.0%296 0.000 0.061 0.500
history write00:12:29.487 0.9%1978592 0.068 0.379 1.664
hiswrite/artcncl00:00:00.004 0.0%23 0.000 0.174 1.000
idle19:29:15.011 81.2%36120166 1.227 1.942 46.835
nntp read00:29:37.149 2.1%35866198 0.030 0.050 0.065
overview write00:00:09.710 0.0%1978447 0.001 0.005 0.009
perl filter02:48:48.937 11.7%1978592 3.419 5.119 10.113
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:01:46.430 0.1%3972236 0.020 0.027 0.036
TOTAL: 24:00:04.94123:44:14.937 98.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.156 0.0%55518 0.000 0.003 0.020
article prepare00:00:00.002 0.0%4584 0.000 0.000 0.050
article read00:00:09.569 0.0%1150 0.000 8.321 143.273
backlog stats00:00:00.123 0.0%139556 0.000 0.001 0.004
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:01.181 0.0%66916 0.005 0.018 0.043
data write00:00:03.227 0.0%51542 0.012 0.063 0.150
idle23:53:39.374100.0%139556 407.626 616.379 1031.830
status file00:00:14.634 0.0%16983 0.556 0.862 1.965
TOTAL: 23:54:14.90123:54:08.266100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:32.037 69.5%3064 0.000 10.456 9742.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.367 0.8%6763 0.000 0.054 5.333
readart00:00:00.002 0.0%32 0.000 0.062 0.500
TOTAL: 00:00:46.09500:00:32.406 70.3%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 41 19542751954126 0 149 99%52:43:17
2news.icm.edu.pl 43 207 20 171 16 9%15:31:17
3localhost 5 4 4 0 0 100%00:00:00
TOTAL: 3 89 19544861954150 171 165 99%68:14:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl309.9 GB876.1 KB1.2 MB309.9 GB 99%166.3 KB
2news.icm.edu.pl737.6 KB10.7 KB415.8 KB1.1 MB 63%32.3 KB
3localhost6.5 KB0.0 KB0.0 KB6.5 KB100%1.6 KB
TOTAL: 3309.9 GB886.8 KB1.6 MB309.9 GB 99%166.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 9 04:15:02 - 04:59:59 101558 5.2% 37.649.4 GB 3.0%3638.13
Sep 9 05:00:00 - 05:59:59 93543 4.8% 25.9813.7 GB 4.4%3996.65
Sep 9 06:00:00 - 06:59:59 134511 6.9% 37.3613.7 GB 4.4%3981.70
Sep 9 07:00:00 - 07:59:59 63219 3.2% 17.5614.9 GB 4.8%4349.97
Sep 9 08:00:00 - 08:59:59 54860 2.8% 15.2414.7 GB 4.7%4267.20
Sep 9 09:00:00 - 09:59:59 64199 3.3% 17.8314.9 GB 4.8%4333.05
Sep 9 10:00:00 - 10:59:59 87515 4.5% 24.3114.2 GB 4.5%4139.04
Sep 9 11:00:00 - 11:59:59 53574 2.7% 14.8813.9 GB 4.4%4040.74
Sep 9 12:00:00 - 12:59:59 41355 2.1% 11.4913.9 GB 4.4%4037.57
Sep 9 13:00:00 - 13:59:59 50427 2.6% 14.0115.1 GB 4.8%4393.33
Sep 9 14:00:00 - 14:59:59 48982 2.5% 13.6115.4 GB 4.9%4480.26
Sep 9 15:00:00 - 15:59:59 58844 3.0% 16.3515.1 GB 4.8%4387.75
Sep 9 16:00:00 - 16:59:59 128546 6.6% 35.7114.7 GB 4.7%4284.15
Sep 9 17:00:00 - 17:59:59 53736 2.7% 14.9313.5 GB 4.3%3927.39
Sep 9 18:00:00 - 18:59:59 104497 5.3% 29.0314.8 GB 4.7%4316.56
Sep 9 19:00:00 - 19:59:59 114879 5.9% 31.9114.8 GB 4.7%4319.43
Sep 9 20:00:00 - 20:59:59 46520 2.4% 12.9215.3 GB 4.9%4450.55
Sep 9 21:00:00 - 21:59:59 70306 3.6% 19.5315.1 GB 4.8%4407.35
Sep 9 22:00:00 - 22:59:59 155035 7.9% 43.0713.7 GB 4.4%3990.76
Sep 9 23:00:00 - 23:59:59 35904 1.8% 9.974.9 GB 1.6%1431.51
Sep 10 00:00:00 - 00:59:59 68990 3.5% 19.1614.3 GB 4.6%4152.52
Sep 10 01:00:00 - 01:59:59 194222 9.9% 53.9513.8 GB 4.4%4013.01
Sep 10 02:00:00 - 02:59:59 127333 6.5% 35.378.2 GB 2.6%2382.93
Sep 10 03:00:00 - 03:59:59 5702 0.3% 1.58680.4 MB 0.2% 193.53
Sep 10 04:00:00 - 04:15:01 2185 0.1% 2.43334.1 MB 0.1% 379.68
TOTAL: 23:59:59 1960442 100.0% 22.69312.8 GB 100.0%3795.82
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 592 128 0 19 2 0 0 0 443
2news.icm.edu.pl 16 0 0 1 0 0 0 0 15
TOTAL: 2 608 128 0 20 2 0 0 0 458

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 70
it.tlc.cellulari.android 33
it.comp.os.win.windows10 16
comp.mobile.android 3
nl.comp.os.linux.techniek 2
nl.comp.sys.android 2
de.rec.sf.startrek 1
de.comp.lang.php 1
TOTAL: 8 128

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

GroupsCount
pl.sci.matematyka 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 13
Binary in non-binary group 2
TOTAL: 2 15

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 28025 412 14676 118 0 0 1%23:50:02
2panorama 42208 227 13735 93 8 41693 0%23:59:57
3nask 0 0 0 0 0 10343 0%23:50:00
4okapi 0 0 0 0 0 1120 0%23:57:50
5poznan 17 0 13 0 0 0 0%01:56:12
TOTAL: 5 70250 639 28424 211 8 53156 0%97:34:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.3 MB6.0 MB7.3 MB0.1 KB/s14.1 KB23:50:02
2panorama676.1 KB380.4 KB1.0 MB0.0 KB/s3.3 KB23:59:57
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:00
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:56:12
TOTAL: 51.9 MB6.4 MB8.3 MB0.0 KB/s10.0 KB97:34:01
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3241.6 KB 12 0 000:00:17
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 3241.6 KB 12 4 000:00:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 580 3241.6 KB 12 4 000:00:27
2*.toya.net.pl 2 00.0 KB 0 0 000:00:04
3unresolved 102 00.0 KB 0 0 000:00:12
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 4 685 3241.6 KB 12 4 000:00:45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.304 3.580 0.00000:00:17
159.203.199.29 0.000 0.020 0.00000:00:09
mon.man.lodz.pl 3.052 9.032 0.00000:00:09
staticline-31-183-132-211.toya.net.pl 0.016 0.028 0.00000:00:04
80.111.142.213 0.020 0.048 0.00000:00:01
212.51.192.185 0.420 1.112 0.00000:00:00
scan-141.security.ipip.net 0.008 0.012 0.00000:00:00
106.75.22.216 0.000 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.048 0.060 0.00000:00:00
TOTAL: 9 4.868 13.904 0.00000:00:45

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
staticline-31-183-132-211.toya.net.pl 2
106.75.22.216 1
scan-141.security.ipip.net 1
159.203.199.29 1
TOTAL: 7 393

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

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 24
2pl.comp.pecet 8
TOTAL: 2 32