Daily Usenet report

Sep 5 04:15:02 -- Sep 6 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Sep 5 10:02:20 newsfeed overchan[30649]: input line too long, skipping
Sep 5 10:02:55 newsfeed overchan[30649]: input line too long, skipping
Sep 5 10:04:02 newsfeed overchan[30649]: input line too long, skipping
Sep 5 11:44:05 newsfeed nnrpd[15429]: SERVER perl filter not defined
Sep 5 14:31:07 newsfeed nnrpd[21705]: SERVER perl filter not defined
Sep 5 14:35:18 newsfeed nnrpd[21808]: SERVER perl filter not defined
Sep 5 15:15:45 newsfeed overchan[30649]: input line too long, skipping
Sep 5 15:42:55 newsfeed overchan[30649]: input line too long, skipping
Sep 5 16:23:21 newsfeed nnrpd[25738]: SERVER perl filter not defined
Sep 5 16:23:52 newsfeed overchan[30649]: input line too long, skipping
Sep 5 16:33:25 newsfeed overchan[30649]: input line too long, skipping
Sep 5 18:12:20 newsfeed overchan[30649]: input line too long, skipping
Sep 5 18:27:33 newsfeed overchan[30649]: input line too long, skipping
Sep 5 18:41:27 newsfeed overchan[30649]: input line too long, skipping
Sep 5 19:18:59 newsfeed overchan[30649]: input line too long, skipping
Sep 5 21:44:22 newsfeed overchan[30649]: input line too long, skipping
Sep 5 21:57:14 newsfeed overchan[30649]: input line too long, skipping
Sep 5 23:38:29 newsfeed overchan[30649]: input line too long, skipping
Sep 5 23:57:46 newsfeed overchan[30649]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2144965 97.6%251.1 MB 97.3%
innfeed 30382 1.4%3.6 MB 1.4%
innd 18221 0.8%2.9 MB 1.1%
nnrpd 4794 0.2%503.0 KB 0.2%
overchan 16 0.0%2.4 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62198379 100.0%258.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2130334 95.6%
Negative hits 85961 3.9%
Positive hits 12253 0.5%
Cache misses 110 0.0%
TOTAL: 4 2228658 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.652 0.0%215 0.000 7.684 114.000
article cleanup00:00:34.793 0.0%2144266 0.011 0.016 0.021
article logging00:01:32.475 0.1%2144735 0.032 0.043 0.136
article parse01:06:41.673 4.6%167215606 0.015 0.024 0.034
article write00:21:05.611 1.5%2137511 0.293 0.592 1.038
artlog/artcncl00:00:00.005 0.0%197 0.000 0.025 0.333
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:02.380 0.2%181586078 0.001 0.001 0.003
hisgrep/artcncl00:00:00.405 0.0%200 0.000 2.025 24.556
hishave/artcncl00:00:00.088 0.0%215 0.000 0.409 5.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:36:05.208 2.5%2241000 0.043 0.966 6.238
history sync00:00:00.017 0.0%290 0.000 0.059 1.000
history write01:43:55.220 7.2%2141217 0.330 2.912 9.413
hiswrite/artcncl00:00:00.007 0.0%15 0.000 0.467 1.500
idle13:06:11.474 54.6%122070675 0.213 0.386 0.915
nntp read01:22:35.630 5.7%165613930 0.021 0.030 0.043
overview write00:00:13.295 0.0%2137511 0.004 0.006 0.008
perl filter04:58:37.626 20.7%2141217 3.857 8.368 9.362
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:05.627 0.3%4295875 0.043 0.057 0.075
TOTAL: 24:00:01.04123:24:43.186 97.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.157 0.0%47355 0.000 0.003 0.016
article prepare00:00:00.010 0.0%11102 0.000 0.001 0.022
article read00:01:09.001 0.1%2792 0.000 24.714 471.000
backlog stats00:00:00.173 0.0%157913 0.000 0.001 0.005
callbacks00:00:00.000 0.0%14 0.000 0.000 0.000
data read00:00:02.029 0.0%84606 0.007 0.024 0.054
data write00:00:05.048 0.0%66358 0.024 0.076 0.315
idle23:52:54.068 99.9%157913 256.476 544.439 1536.426
status file00:00:12.601 0.0%10419 0.655 1.209 16.050
TOTAL: 23:54:36.64423:54:23.087100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.875 60.9%3072 0.000 6.470 109.091
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.170 0.5%6832 0.000 0.025 0.667
readart00:00:00.003 0.0%66 0.000 0.045 0.500
TOTAL: 00:00:32.62200:00:20.048 61.5%----

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 829 21372122127314 6931 2967 99%340:17:40
2news.nask.pl 2 15794 10004 1983 3807 63%23:52:35
3news.icm.edu.pl 44 320 29 264 27 9%17:23:31
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 880 21533302137351 9178 6801 99%381:33:46
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl742.8 GB21.4 MB21.9 MB742.8 GB 99%365.6 KB
2news.nask.pl46.4 MB799.0 KB26.6 MB73.8 MB 62%5.5 KB
3news.icm.edu.pl950.9 KB0.0 KB1.4 MB2.3 MB 40%41.9 KB
4localhost5.6 KB0.0 KB0.0 KB5.6 KB100%1.4 KB
TOTAL: 4742.8 GB22.1 MB49.9 MB742.9 GB 99%363.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 5 04:15:02 - 04:59:59 65477 3.1% 24.2723.8 GB 3.2%9244.76
Sep 5 05:00:00 - 05:59:59 95366 4.5% 26.4935.9 GB 4.8%10465.38
Sep 5 06:00:00 - 06:59:59 89716 4.2% 24.9233.8 GB 4.6%9845.19
Sep 5 07:00:00 - 07:59:59 82445 3.9% 22.9030.8 GB 4.1%8965.96
Sep 5 08:00:00 - 08:59:59 100813 4.7% 28.0038.1 GB 5.1%11091.92
Sep 5 09:00:00 - 09:59:59 89777 4.2% 24.9434.0 GB 4.6%9892.70
Sep 5 10:00:00 - 10:59:59 131375 6.1% 36.4940.7 GB 5.5%11858.94
Sep 5 11:00:00 - 11:59:59 127801 6.0% 35.5042.3 GB 5.7%12325.45
Sep 5 12:00:00 - 12:59:59 119194 5.6% 33.1142.3 GB 5.7%12330.09
Sep 5 13:00:00 - 13:59:59 110418 5.2% 30.6741.5 GB 5.6%12100.09
Sep 5 14:00:00 - 14:59:59 111764 5.2% 31.0540.4 GB 5.4%11780.94
Sep 5 15:00:00 - 15:59:59 73463 3.4% 20.4128.9 GB 3.9%8405.63
Sep 5 16:00:00 - 16:59:59 69459 3.2% 19.2925.5 GB 3.4%7422.60
Sep 5 17:00:00 - 17:59:59 68632 3.2% 19.0625.5 GB 3.4%7434.44
Sep 5 18:00:00 - 18:59:59 70975 3.3% 19.7225.2 GB 3.4%7330.87
Sep 5 19:00:00 - 19:59:59 77178 3.6% 21.4425.7 GB 3.5%7483.58
Sep 5 20:00:00 - 20:59:59 82048 3.8% 22.7928.7 GB 3.9%8346.66
Sep 5 21:00:00 - 21:59:59 86052 4.0% 23.9027.8 GB 3.7%8095.00
Sep 5 22:00:00 - 22:59:59 83251 3.9% 23.1325.5 GB 3.4%7437.63
Sep 5 23:00:00 - 23:59:59 81017 3.8% 22.5026.0 GB 3.5%7578.97
Sep 6 00:00:00 - 00:59:59 53993 2.5% 15.0018.7 GB 2.5%5443.49
Sep 6 01:00:00 - 01:59:59 75527 3.5% 20.9824.7 GB 3.3%7207.22
Sep 6 02:00:00 - 02:59:59 100207 4.7% 27.8426.3 GB 3.5%7648.27
Sep 6 03:00:00 - 03:59:59 68998 3.2% 19.1723.1 GB 3.1%6740.68
Sep 6 04:00:00 - 04:15:02 22600 1.1% 25.067.3 GB 1.0%8432.23
TOTAL: 24:00:00 2137546 100.0% 24.74742.5 GB 100.0%9011.37
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 3931 37 0 285 3 0 0 0 3606
2newsfeed.pionier.net.pl 3264 179 0 2764 0 0 0 0 321
3news.icm.edu.pl 27 0 0 0 0 0 0 0 27
TOTAL: 3 7222 216 0 3049 3 0 0 0 3954

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 80
it.tlc.cellulari.android 76
comp.mobile.android 41
hr.ponuda.hardver.komponente 5
nl.comp.sys.android 3
de.comp.lang.vbclassic 2
it.comp.os.linux.ubuntu 2
it.comp.os.win.windows10 2
sci.physics.acoustics 2
de.comp.lang.php 1
alt.sex.telephones 1
uk.rec.cycling.moderated 1
TOTAL: 12 216

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

GroupsCount
pl.praca.oferowana 2
bit.listserv.catholic 1
TOTAL: 2 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3261
Binary in non-binary group 129
Scoring filter (8) 38
Poison newsgroup 22
Scoring filter (9) 12
HTML post 8
Scoring filter (10) 6
Too many newsgroups 3
Scoring filter (13) 2
Scoring filter (12) 2
Scoring filter (11) 1
Scoring filter (17) 1
TOTAL: 12 3485

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 298
news.nask.pl 171
TOTAL: 2 469
TOTAL: 1 469

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 28468 734 10208 194 39 36301 2%23:59:29
2poznan 16192 191 9803 42 0 1 1%23:59:58
3icm 26859 75 19407 908 0 0 0%23:52:14
4nask 4102 1 2733 0 0 0 0%23:50:01
5okapi 0 0 0 0 0 2073 0%23:57:50
TOTAL: 5 75621 1001 42151 1144 39 38375 1%119:39:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama2.5 MB1.5 MB4.0 MB0.0 KB/s4.4 KB23:59:29
2poznan740.1 KB215.1 KB955.2 KB0.0 KB/s4.1 KB23:59:58
3icm669.3 KB315.7 MB316.4 MB3.8 KB/s329.6 KB23:52:14
4nask1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:50:01
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 53.9 MB317.4 MB321.3 MB0.8 KB/s153.4 KB119:39:32
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama976.8 KB
TOTAL: 1976.8 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 6670.5 KB 29 0 000:00:26
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 292 6670.5 KB 29 4 000:00:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 676 6670.5 KB 29 4 000:00:31
TOTAL: 1 676 6670.5 KB 29 4 000:00:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.424 4.104 0.00000:00:26
mon.man.lodz.pl 1.272 4.192 0.00000:00:03
david.man.lodz.pl 0.412 1.344 0.00000:00:01
isvcs01.man.lodz.pl 0.044 0.080 0.00000:00:00
TOTAL: 4 3.152 9.720 0.00000:00:31

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
TOTAL: 2 384

Newsgroup request counts (by category):

CategoryCountPct
1pl 66100.0%
TOTAL: 1 66100.0%

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

NewsgroupCount
1pl.comp.pecet 52
2pl.comp.os.ms-windows.winnt 14
TOTAL: 2 66