Daily Usenet report

Oct 7 04:15:03 -- Oct 8 04:15:02

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Oct 7 04:31:16 newsfeed overchan[23322]: input line too long, skipping
Oct 7 13:16:41 newsfeed overchan[23322]: input line too long, skipping
Oct 7 13:22:48 newsfeed overchan[23322]: input line too long, skipping
Oct 7 13:22:58 newsfeed overchan[23322]: input line too long, skipping
Oct 7 19:27:40 newsfeed overchan[23322]: input line too long, skipping
Oct 7 19:44:08 newsfeed overchan[23322]: input line too long, skipping
Oct 7 21:02:02 newsfeed overchan[23322]: input line too long, skipping
Oct 7 22:26:24 newsfeed overchan[23322]: input line too long, skipping
Oct 7 23:55:08 newsfeed overchan[23322]: input line too long, skipping
Oct 8 00:05:34 newsfeed overchan[23322]: input line too long, skipping
Oct 8 03:54:09 newsfeed overchan[23322]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2230944 97.5%263.3 MB 97.2%
innfeed 37652 1.6%4.4 MB 1.6%
innd 15855 0.7%2.6 MB 1.0%
nnrpd 4850 0.2%515.7 KB 0.2%
overchan 12 0.0%2.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62289314 100.0%270.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2207277 87.1%
Positive hits 222358 8.8%
Negative hits 103429 4.1%
Cache misses 2040 0.1%
TOTAL: 4 2535104 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.225 0.0%51 0.000 43.627 448.000
article cleanup00:00:33.696 0.0%2234848 0.009 0.015 0.021
article logging00:02:04.109 0.1%2235295 0.036 0.056 0.109
article parse00:51:11.286 3.6%83027149 0.017 0.037 0.049
article write00:20:32.224 1.4%2216680 0.279 0.556 0.941
artlog/artcncl00:00:00.003 0.0%51 0.000 0.059 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:03:27.900 0.2%96412442 0.001 0.002 0.004
hisgrep/artcncl00:00:00.300 0.0%49 0.000 6.122 63.000
hishave/artcncl00:00:00.087 0.0%51 0.000 1.706 13.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:21:31.416 9.8%2549334 0.698 3.331 7.419
history sync00:00:00.016 0.0%290 0.000 0.055 1.000
history write04:46:07.407 19.9%2218898 2.872 7.737 13.390
hiswrite/artcncl00:00:00.022 0.0%2 0.000 11.000 22.000
idle09:01:01.633 37.6%56198130 0.168 0.578 1.149
nntp read01:08:42.048 4.8%81458988 0.030 0.051 0.067
overview write00:00:13.730 0.0%2216680 0.004 0.006 0.012
perl filter04:52:39.664 20.3%2218894 4.101 7.914 10.119
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:55.254 0.4%4722194 0.049 0.075 0.106
TOTAL: 24:00:04.58423:34:03.020 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.779 0.0%522434 0.001 0.003 0.006
article prepare00:00:00.091 0.0%270936 0.000 0.000 0.002
article read00:01:05.171 0.1%60196 0.000 1.083 16.514
backlog stats00:00:02.207 0.0%1995681 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:27.247 0.0%1070838 0.014 0.025 0.036
data write00:04:07.376 0.3%1047335 0.069 0.236 0.614
idle23:43:10.227 99.5%1995681 18.326 42.788 116.243
status file00:00:29.277 0.0%15850 0.571 1.847 11.667
TOTAL: 23:50:29.41523:49:23.375 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:17.790 51.4%3027 0.000 5.877 182.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.433 1.3%6726 0.000 0.064 17.000
readart00:00:00.002 0.0%48 0.000 0.042 0.500
TOTAL: 00:00:34.61400:00:18.225 52.7%----

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 514 22093782204242 1500 3636 99%521:53:37
2news.nask.pl 3 228555 7386 206759 14410 3%24:23:00
3news.icm.edu.pl 42 263 89 119 55 33%15:13:02
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 560 24381962211717 208378 18101 90%561:29:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl717.2 GB655.3 MB659.1 MB718.5 GB 99%341.2 KB
2news.nask.pl2.1 GB5.6 GB5.6 GB13.2 GB 15%636.1 KB
3news.icm.edu.pl1.8 MB24.3 KB1.3 MB3.2 MB 57%22.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4719.3 GB6.2 GB6.2 GB731.7 GB 98%344.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 7 04:15:03 - 04:59:59 74883 3.4% 27.7728.4 GB 3.9%11033.60
Oct 7 05:00:00 - 05:59:59 87410 4.0% 24.2833.8 GB 4.7%9843.18
Oct 7 06:00:00 - 06:59:59 111831 5.1% 31.0635.8 GB 5.0%10415.92
Oct 7 07:00:00 - 07:59:59 85253 3.9% 23.6832.5 GB 4.5%9468.97
Oct 7 08:00:00 - 08:59:59 87051 3.9% 24.1833.9 GB 4.7%9880.93
Oct 7 09:00:00 - 09:59:59 97629 4.4% 27.1232.9 GB 4.6%9572.40
Oct 7 10:00:00 - 10:59:59 87664 4.0% 24.3533.7 GB 4.7%9801.43
Oct 7 11:00:00 - 11:59:59 83444 3.8% 23.1833.3 GB 4.6%9688.26
Oct 7 12:00:00 - 12:59:59 85830 3.9% 23.8434.6 GB 4.8%10067.15
Oct 7 13:00:00 - 13:59:59 91692 4.1% 25.4734.8 GB 4.8%10143.01
Oct 7 14:00:00 - 14:59:59 85076 3.8% 23.6330.1 GB 4.2%8757.60
Oct 7 15:00:00 - 15:59:59 91513 4.1% 25.4230.9 GB 4.3%9006.18
Oct 7 16:00:00 - 16:59:59 106439 4.8% 29.5732.6 GB 4.5%9503.78
Oct 7 17:00:00 - 17:59:59 81867 3.7% 22.7421.8 GB 3.0%6354.03
Oct 7 18:00:00 - 18:59:59 122016 5.5% 33.8920.8 GB 2.9%6059.48
Oct 7 19:00:00 - 19:59:59 138789 6.3% 38.5526.9 GB 3.7%7844.26
Oct 7 20:00:00 - 20:59:59 87808 4.0% 24.3925.7 GB 3.6%7471.23
Oct 7 21:00:00 - 21:59:59 124568 5.6% 34.6035.6 GB 4.9%10355.60
Oct 7 22:00:00 - 22:59:59 79493 3.6% 22.0826.5 GB 3.7%7724.94
Oct 7 23:00:00 - 23:59:59 78504 3.5% 21.8126.3 GB 3.7%7668.22
Oct 8 00:00:00 - 00:59:59 64386 2.9% 17.8921.9 GB 3.0%6372.37
Oct 8 01:00:00 - 01:59:59 82116 3.7% 22.8126.3 GB 3.7%7656.33
Oct 8 02:00:00 - 02:59:59 80835 3.7% 22.4527.3 GB 3.8%7949.43
Oct 8 03:00:00 - 03:59:59 80522 3.6% 22.3727.7 GB 3.9%8072.61
Oct 8 04:00:00 - 04:15:02 15661 0.7% 17.365.5 GB 0.8%6386.92
TOTAL: 23:59:59 2212280 100.0% 25.61719.4 GB 100.0%8731.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 14570 18 0 12484 1 0 0 0 2067
2newsfeed.pionier.net.pl 3983 137 0 3453 4 0 0 0 389
3news.icm.edu.pl 60 0 0 2 0 0 0 0 58
TOTAL: 3 18613 155 0 15939 5 0 0 0 2514

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 47
comp.mobile.android 41
it.tlc.cellulari.android 26
it.comp.os.win.windows10 25
it.comp.os.linux.ubuntu 5
it.comp.os.win.windows7 4
comp.mobile.ipad 3
nl.comp.os.linux.techniek 2
hr.ponuda.hardver.komponente 1
comp.sys.raspberry-pi 1
TOTAL: 10 155

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

GroupsCount
pl.sci.matematyka 4
bit.listserv.catholic 1
TOTAL: 2 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1968
Binary in non-binary group 37
EMP (phl) 32
Scoring filter (8) 6
Scoring filter (10) 6
Scoring filter (16) 5
Scoring filter (11) 3
Scoring filter (9) 2
Scoring filter (14) 1
EMP (fsl) 1
Too many newsgroups 1
Attached HTML file 1
TOTAL: 12 2063

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 4
TOTAL: 1 4
Including strange strings
newsfeed.pionier.net.pl 348
news.nask.pl 94
news.icm.edu.pl 5
TOTAL: 3 447
TOTAL: 2 451

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 408292 39887 232986 1643 0 279 9%23:59:57
2panorama 282404 1366 254384 102 0 268134 0%23:59:57
3icm 318666 67 262302 24894 0 227 0%23:59:57
4poznan 5047 57 3691 10 0 0 1%23:58:28
5okapi 0 0 0 0 0 824 0%23:57:50
TOTAL: 51014409 41377 753363 26649 0 269464 4%119:56:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask21.7 GB805.0 MB22.5 GB272.7 KB/s567.2 KB23:59:57
2panorama778.7 MB34.9 MB813.6 MB9.6 KB/s567.5 KB23:59:57
3icm5.7 MB13.5 GB13.5 GB163.4 KB/s565.6 KB23:59:57
4poznan255.6 KB46.0 KB301.5 KB0.0 KB/s4.5 KB23:58:28
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 522.4 GB14.3 GB36.7 GB89.2 KB/s566.1 KB119:56:09
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4862.4 KB 23 0 000:00:25
TOTAL: 1 288 4862.4 KB 23 0 000:00:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 576 4862.4 KB 23 0 000:00:30
2unresolved 96 00.0 KB 0 0 000:00:01
3*.dhcp.chtrptr.net 1 00.0 KB 0 0 000:00:01
TOTAL: 3 673 4862.4 KB 23 0 000:00:33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.900 6.732 0.00000:00:25
mon.man.lodz.pl 1.520 5.452 0.00000:00:04
212.51.192.185 0.456 1.936 0.00000:00:01
172-221-041-102.dhcp.chtrptr.net 0.008 0.008 0.00000:00:01
TOTAL: 4 3.884 14.128 0.00000:00:33

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
172-221-041-102.dhcp.chtrptr.net 1
TOTAL: 3 385

Newsgroup request counts (by category):

CategoryCountPct
1pl 48100.0%
TOTAL: 1 48100.0%

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

NewsgroupCount
1pl.comp.pecet 26
2pl.comp.os.ms-windows.winnt 22
TOTAL: 2 48