Daily Usenet report

Sep 10 04:15:02 -- Sep 11 04:15:02

Unknown entries from news log file:

First 22 / 22 lines (100.0%)

Sep 10 04:23:06 newsfeed overchan[14326]: input line too long, skipping
Sep 10 06:52:05 newsfeed overchan[14326]: input line too long, skipping
Sep 10 06:52:37 newsfeed overchan[14326]: input line too long, skipping
Sep 10 06:53:05 newsfeed overchan[14326]: input line too long, skipping
Sep 10 07:36:11 newsfeed overchan[14326]: input line too long, skipping
Sep 10 08:29:38 newsfeed overchan[14326]: input line too long, skipping
Sep 10 09:15:00 newsfeed overchan[14326]: input line too long, skipping
Sep 10 09:30:10 newsfeed overchan[14326]: input line too long, skipping
Sep 10 09:48:33 newsfeed overchan[14326]: input line too long, skipping
Sep 10 09:48:59 newsfeed overchan[14326]: input line too long, skipping
Sep 10 09:52:08 newsfeed overchan[14326]: input line too long, skipping
Sep 10 09:56:31 newsfeed overchan[14326]: input line too long, skipping
Sep 10 12:02:53 newsfeed overchan[14326]: input line too long, skipping
Sep 10 13:28:22 newsfeed nnrpd[3327]: SERVER perl filter not defined
Sep 10 13:30:30 newsfeed overchan[14326]: input line too long, skipping
Sep 10 14:22:20 newsfeed overchan[14326]: input line too long, skipping
Sep 10 16:17:05 newsfeed overchan[14326]: input line too long, skipping
Sep 10 16:17:17 newsfeed overchan[14326]: input line too long, skipping
Sep 10 16:43:03 newsfeed overchan[14326]: input line too long, skipping
Sep 10 17:40:29 newsfeed overchan[14326]: input line too long, skipping
Sep 10 18:28:23 newsfeed overchan[14326]: input line too long, skipping
Sep 10 22:23:10 newsfeed overchan[14326]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2837200 97.4%326.0 MB 97.1%
innfeed 49713 1.7%5.9 MB 1.8%
innd 21012 0.7%3.5 MB 1.0%
nnrpd 4782 0.2%508.1 KB 0.1%
overchan 22 0.0%3.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62912730 100.0%335.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2812769 95.3%
Positive hits 81457 2.8%
Negative hits 57297 1.9%
Cache misses 494 0.0%
TOTAL: 4 2952017 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.873 0.0%77 0.000 24.325 525.000
article cleanup00:00:37.663 0.0%2837929 0.008 0.013 0.017
article logging00:02:12.087 0.2%2838514 0.032 0.047 0.250
article parse00:50:52.394 3.5%100662709 0.020 0.030 0.041
article write00:19:30.717 1.4%2831627 0.294 0.413 0.802
artlog/artcncl00:00:00.001 0.0%77 0.000 0.013 1.000
artlog/artparse00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:02:02.141 0.1%116956736 0.001 0.001 0.002
hisgrep/artcncl00:00:00.175 0.0%74 0.000 2.365 30.000
hishave/artcncl00:00:00.061 0.0%77 0.000 0.792 5.200
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:30:52.207 2.1%2974119 0.118 0.623 2.790
history sync00:00:00.024 0.0%290 0.000 0.083 1.000
history write01:36:24.267 6.7%2833822 0.421 2.041 7.642
hiswrite/artcncl00:00:00.005 0.0%3 0.000 1.667 5.000
idle14:27:54.549 60.3%73708375 0.522 0.706 1.387
nntp read01:12:30.861 5.0%98519334 0.031 0.044 0.060
overview write00:00:13.794 0.0%2831627 0.003 0.005 0.007
perl filter04:23:53.114 18.3%2833819 4.048 5.587 7.806
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:11.333 0.4%5835305 0.035 0.053 0.068
TOTAL: 24:00:01.66823:32:17.266 98.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.934 0.0%320106 0.000 0.003 0.011
article prepare00:00:00.097 0.0%380136 0.000 0.000 0.050
article read00:03:55.520 0.3%88064 0.000 2.674 241.333
backlog stats00:00:01.249 0.0%1430520 0.000 0.001 0.002
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:12.941 0.0%662028 0.006 0.020 0.039
data write00:04:59.189 0.3%784934 0.031 0.381 0.623
idle23:42:18.512 99.3%1430520 13.141 59.656 858.584
status file00:00:19.659 0.0%17012 0.858 1.156 1.758
TOTAL: 23:52:36.49923:51:48.101 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:44.119 78.9%3043 0.000 14.499 10028.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.237 0.4%6784 0.000 0.035 1.000
readart00:00:00.001 0.0%44 0.000 0.023 0.500
TOTAL: 00:00:55.92400:00:44.357 79.3%----

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 1030 28305022825370 2094 3038 99%391:42:14
2news.nask.pl 3 81076 4434 73421 3221 5%23:47:26
3news.icm.edu.pl 47 314 120 169 25 38%18:52:35
4localhost 2 1 1 0 0 100%00:00:01
TOTAL: 4 1082 29118932829925 75684 6284 97%434:22:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl818.0 GB22.2 MB316.7 MB818.4 GB 99%303.4 KB
2news.nask.pl91.6 MB53.5 MB64.1 MB209.1 MB 43%28.0 KB
3news.icm.edu.pl2.8 MB0.0 KB626.8 KB3.4 MB 81%23.9 KB
4localhost1.8 KB0.0 KB0.0 KB1.8 KB100%1.8 KB
TOTAL: 4818.1 GB75.6 MB381.4 MB818.6 GB 99%302.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 10 04:15:02 - 04:59:59 85113 3.0% 31.5524.3 GB 3.0%9454.76
Sep 10 05:00:00 - 05:59:59 122132 4.3% 33.9335.3 GB 4.3%10272.94
Sep 10 06:00:00 - 06:59:59 127726 4.5% 35.4836.7 GB 4.5%10691.10
Sep 10 07:00:00 - 07:59:59 125060 4.4% 34.7436.1 GB 4.4%10519.79
Sep 10 08:00:00 - 08:59:59 131427 4.6% 36.5138.7 GB 4.7%11275.61
Sep 10 09:00:00 - 09:59:59 147932 5.2% 41.0938.3 GB 4.7%11166.74
Sep 10 10:00:00 - 10:59:59 140346 5.0% 38.9839.3 GB 4.8%11440.04
Sep 10 11:00:00 - 11:59:59 138104 4.9% 38.3639.2 GB 4.8%11406.76
Sep 10 12:00:00 - 12:59:59 134195 4.7% 37.2839.1 GB 4.8%11401.87
Sep 10 13:00:00 - 13:59:59 133671 4.7% 37.1339.5 GB 4.8%11492.06
Sep 10 14:00:00 - 14:59:59 135532 4.8% 37.6536.7 GB 4.5%10689.74
Sep 10 15:00:00 - 15:59:59 112111 4.0% 31.1430.8 GB 3.8%8969.00
Sep 10 16:00:00 - 16:59:59 117379 4.1% 32.6133.2 GB 4.1%9659.09
Sep 10 17:00:00 - 17:59:59 134128 4.7% 37.2637.4 GB 4.6%10897.85
Sep 10 18:00:00 - 18:59:59 98195 3.5% 27.2828.3 GB 3.5%8252.92
Sep 10 19:00:00 - 19:59:59 66956 2.4% 18.6019.8 GB 2.4%5756.15
Sep 10 20:00:00 - 20:59:59 100486 3.6% 27.9132.1 GB 3.9%9351.11
Sep 10 21:00:00 - 21:59:59 120210 4.2% 33.3939.1 GB 4.8%11393.16
Sep 10 22:00:00 - 22:59:59 141422 5.0% 39.2837.5 GB 4.6%10933.16
Sep 10 23:00:00 - 23:59:59 133838 4.7% 37.1836.8 GB 4.5%10732.77
Sep 11 00:00:00 - 00:59:59 75295 2.7% 20.9222.8 GB 2.8%6635.64
Sep 11 01:00:00 - 01:59:59 93214 3.3% 25.8928.1 GB 3.4%8195.27
Sep 11 02:00:00 - 02:59:59 100658 3.6% 27.9631.9 GB 3.9%9300.23
Sep 11 03:00:00 - 03:59:59 91662 3.2% 25.4628.1 GB 3.4%8194.66
Sep 11 04:00:00 - 04:15:02 23428 0.8% 25.977.3 GB 0.9%8431.25
TOTAL: 24:00:00 2830220 100.0% 32.76816.5 GB 100.0%9909.42
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3518 162 0 2160 2 0 0 0 1194
2news.nask.pl 3364 3 0 1969 2 0 0 0 1390
3news.icm.edu.pl 21 0 0 0 0 0 0 0 21
TOTAL: 3 6903 165 0 4129 4 0 0 0 2605

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 118
it.tlc.cellulari.android 17
it.comp.os.win.windows10 8
comp.sys.raspberry-pi 7
nl.comp.os.linux.techniek 6
comp.mobile.android 4
uk.rec.cycling.moderated 3
it.discussioni.energia 2
TOTAL: 8 165

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

GroupsCount
pl.praca.oferowana 2
clari.usa.law.supreme 1
bit.listserv.catholic 1
TOTAL: 3 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1193
Binary in non-binary group 754
EMP (phl) 30
Scoring filter (16) 9
Scoring filter (8) 8
Too many newsgroups 7
Scoring filter (14) 5
HTML post 3
Scoring filter (10) 2
Scoring filter (9) 2
Scoring filter (18) 2
Scoring filter (15) 1
Scoring filter (11) 1
TOTAL: 13 2017

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 475
news.nask.pl 109
news.icm.edu.pl 2
TOTAL: 3 586
TOTAL: 1 586

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 216055 83828 78152 25 0 5048 38%23:59:58
2panorama 152790 892 123158 280 8 193575 0%23:59:58
3icm 221696 79 162790 10484 0 4 0%23:59:58
4poznan 6308 28 4339 15 0 0 0%23:58:44
5okapi 0 0 0 0 0 1117 0%23:57:51
TOTAL: 5 596849 84827 368439 10804 8 199744 14%119:56:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask40.2 GB10.0 MB40.2 GB487.6 KB/s502.4 KB23:59:58
2panorama95.7 MB44.7 MB140.4 MB1.7 KB/s122.7 KB23:59:58
3icm2.4 MB4.7 GB4.7 GB57.0 KB/s466.5 KB23:59:58
4poznan134.9 KB69.0 KB203.9 KB0.0 KB/s4.7 KB23:58:44
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 540.3 GB4.8 GB45.0 GB109.3 KB/s493.6 KB119:56:29
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama1.4 MB
okapi488.3 KB
TOTAL: 21.9 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4451.8 KB 19 0 000:00:28
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 4451.8 KB 19 1 000:00:55

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 673 4451.8 KB 19 1 000:00:34
2*.146.166.6.nat.umts.dynamic.t-mobile.pl 4 00.0 KB 0 0 000:00:00
3unresolved 3 00.0 KB 0 0 000:00:20
TOTAL: 3 680 4451.8 KB 19 1 000:00:55

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.248 4.544 0.00000:00:28
89.248.174.55 0.000 0.012 0.00000:00:10
107.170.203.51 0.000 0.012 0.00000:00:09
mon.man.lodz.pl 1.228 4.712 0.00000:00:03
david.man.lodz.pl 0.432 1.640 0.00000:00:01
188.146.166.6.nat.umts.dynamic.t-mobile.pl 0.068 0.088 0.00000:00:00
103.78.132.4 0.008 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.012 0.008 0.00000:00:00
TOTAL: 8 2.996 11.028 0.00000:00:55

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
188.146.166.6.nat.umts.dynamic.t-mobile.pl 4
103.78.132.4 1
89.248.174.55 1
107.170.203.51 1
TOTAL: 6 391

Newsgroup request counts (by category):

CategoryCountPct
1pl 44100.0%
TOTAL: 1 44100.0%

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

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