Daily Usenet report

May 24 04:15:02 -- May 25 04:15:02

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

May 24 07:24:37 newsfeed overchan[11962]: input line too long, skipping
May 24 07:25:00 newsfeed overchan[11962]: input line too long, skipping
May 24 07:25:37 newsfeed overchan[11962]: input line too long, skipping
May 24 07:26:12 newsfeed overchan[11962]: input line too long, skipping
May 24 09:14:28 newsfeed overchan[11962]: input line too long, skipping
May 24 10:10:55 newsfeed overchan[11962]: input line too long, skipping
May 24 10:15:39 newsfeed overchan[11962]: input line too long, skipping
May 24 10:28:30 newsfeed overchan[11962]: input line too long, skipping
May 24 14:39:19 newsfeed overchan[11962]: input line too long, skipping
May 24 16:09:15 newsfeed overchan[11962]: input line too long, skipping
May 25 01:22:11 newsfeed overchan[11962]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn1407282 95.4%165.0 MB 95.1%
innfeed 48478 3.3%5.7 MB 3.3%
innd 13937 0.9%2.2 MB 1.3%
nnrpd 4745 0.3%499.7 KB 0.3%
overchan 12 0.0%2.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 61474455 100.0%173.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1395278 94.2%
Negative hits 71684 4.8%
Positive hits 13741 0.9%
Cache misses 111 0.0%
TOTAL: 4 1480814 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.302 0.0%203 0.000 6.414 51.000
article cleanup00:00:19.646 0.0%1405162 0.010 0.014 0.020
article logging00:00:56.136 0.1%1405709 0.032 0.040 0.072
article parse00:35:22.582 2.5%128980215 0.012 0.016 0.027
article write00:50:41.928 3.5%1398115 0.417 2.176 6.178
artlog/artcncl00:00:00.004 0.0%189 0.000 0.021 0.333
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:47.668 0.2%138509241 0.001 0.001 0.002
hisgrep/artcncl00:00:00.486 0.0%187 0.000 2.599 18.000
hishave/artcncl00:00:00.099 0.0%203 0.000 0.488 2.364
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:38:58.202 2.7%1487565 0.292 1.572 5.683
history sync00:00:00.020 0.0%290 0.000 0.069 1.000
history write02:06:40.949 8.8%1401800 0.857 5.422 9.953
hiswrite/artcncl00:00:00.132 0.0%16 0.000 8.250 10.500
idle15:32:12.192 64.7%110163664 0.263 0.508 1.101
nntp read00:54:55.568 3.8%128006099 0.017 0.026 0.035
overview write00:00:07.468 0.0%1398115 0.004 0.005 0.008
perl filter02:39:27.533 11.1%1401800 5.988 6.825 7.837
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:02:37.629 0.2%3029490 0.037 0.052 0.068
TOTAL: 24:00:04.73423:25:09.544 97.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.917 0.0%310524 0.000 0.003 0.011
article prepare00:00:00.042 0.0%110598 0.000 0.000 0.009
article read00:00:47.615 0.1%27654 0.000 1.722 160.250
backlog stats00:00:00.464 0.0%504900 0.000 0.001 0.003
callbacks00:00:00.000 0.0%9 0.000 0.000 0.000
data read00:00:05.464 0.0%362151 0.004 0.015 0.032
data write00:00:21.420 0.0%132811 0.008 0.161 0.366
idle23:50:54.574 99.9%504900 44.904 170.043 930.524
status file00:00:12.393 0.0%16804 0.538 0.738 0.969
TOTAL: 23:52:48.19123:52:22.889100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:33.054 73.6%3089 0.000 10.701 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.147 0.3%6838 0.000 0.021 0.667
readart00:00:00.002 0.0%42 0.000 0.048 0.500
TOTAL: 00:00:44.90800:00:33.203 73.9%----

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 694 13993991391154 5219 3026 99%307:37:58
2news.nask.pl 2 17173 8113 5009 4051 47%24:07:17
3news.icm.edu.pl 27 169 11 149 9 6%10:28:08
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 724 14167411399278 10377 7086 98%342:13:23
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl462.7 GB35.4 MB42.1 MB462.8 GB 99%348.1 KB
2news.nask.pl57.9 MB1.9 MB24.5 MB84.2 MB 68%7.1 KB
3news.icm.edu.pl306.2 KB17.2 KB285.0 KB608.3 KB 50%30.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4462.8 GB37.3 MB66.8 MB462.9 GB 99%345.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 24 04:15:02 - 04:59:59 51822 3.7% 19.2119.3 GB 4.2%7508.58
May 24 05:00:00 - 05:59:59 64246 4.6% 17.8524.3 GB 5.3%7084.03
May 24 06:00:00 - 06:59:59 78988 5.6% 21.9428.3 GB 6.1%8244.15
May 24 07:00:00 - 07:59:59 78927 5.6% 21.9228.1 GB 6.1%8198.43
May 24 08:00:00 - 08:59:59 75177 5.4% 20.8827.8 GB 6.0%8109.37
May 24 09:00:00 - 09:59:59 68238 4.9% 18.9525.2 GB 5.4%7334.66
May 24 10:00:00 - 10:59:59 38118 2.7% 10.5913.0 GB 2.8%3773.64
May 24 11:00:00 - 11:59:59 40278 2.9% 11.1913.7 GB 3.0%3990.00
May 24 12:00:00 - 12:59:59 39873 2.8% 11.0813.3 GB 2.9%3861.73
May 24 13:00:00 - 13:59:59 40645 2.9% 11.2913.2 GB 2.8%3838.51
May 24 14:00:00 - 14:59:59 38721 2.8% 10.7612.8 GB 2.8%3723.95
May 24 15:00:00 - 15:59:59 36411 2.6% 10.1111.1 GB 2.4%3245.57
May 24 16:00:00 - 16:59:59 41650 3.0% 11.5713.7 GB 3.0%3987.43
May 24 17:00:00 - 17:59:59 44044 3.1% 12.2314.0 GB 3.0%4079.85
May 24 18:00:00 - 18:59:59 45063 3.2% 12.5213.5 GB 2.9%3944.53
May 24 19:00:00 - 19:59:59 44474 3.2% 12.3514.2 GB 3.1%4140.07
May 24 20:00:00 - 20:59:59 48183 3.4% 13.3815.3 GB 3.3%4445.71
May 24 21:00:00 - 21:59:59 46580 3.3% 12.9415.5 GB 3.4%4516.43
May 24 22:00:00 - 22:59:59 42072 3.0% 11.6915.4 GB 3.3%4485.63
May 24 23:00:00 - 23:59:59 40523 2.9% 11.2612.7 GB 2.8%3704.68
May 25 00:00:00 - 00:59:59 85133 6.1% 23.6525.1 GB 5.4%7301.06
May 25 01:00:00 - 01:59:59 109756 7.8% 30.4930.9 GB 6.7%8994.94
May 25 02:00:00 - 02:59:59 109007 7.8% 30.2830.4 GB 6.6%8845.33
May 25 03:00:00 - 03:59:59 73794 5.3% 20.5025.0 GB 5.4%7276.71
May 25 04:00:00 - 04:15:02 17753 1.3% 19.686.6 GB 1.4%7729.37
TOTAL: 24:00:00 1399476 100.0% 16.20462.4 GB 100.0%5612.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 4142 17 0 661 5 0 0 0 3459
2newsfeed.pionier.net.pl 3466 195 0 2704 5 0 0 0 562
3news.icm.edu.pl 9 0 0 2 0 0 0 0 7
TOTAL: 3 7617 212 0 3367 10 0 0 0 4028

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 142
it.comp.os.win.windows10 27
it.tlc.cellulari.android 16
comp.mobile.android 13
de.comp.lang.vbclassic 4
de.comp.office-pakete.ms-office.word 3
comp.sys.mac.vintage 3
it.discussioni.energia 1
comp.sys.raspberry-pi 1
de.comp.lang.perl 1
it.comp.os.win.windows7 1
TOTAL: 11 212

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

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

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3046
Binary in non-binary group 189
Too many newsgroups (low_xpost) 66
EMP (phl) 64
Scoring filter (8) 44
Scoring filter (9) 28
Poison newsgroup 11
Too many newsgroups 10
Scoring filter (10) 9
HTML post 3
Scoring filter (11) 3
Scoring filter (12) 3
Scoring filter (17) 2
Scoring filter (15) 1
Scoring filter (13) 1
TOTAL: 15 3480

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 435
news.nask.pl 113
TOTAL: 2 548
TOTAL: 1 548

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 42585 24798 12841 318 0 194849 58%23:59:57
2panorama 92806 1252 63083 596 25 248970 1%23:59:58
3poznan 11292 69 7790 10 0 0 0%23:59:46
4nask 10282 2 6774 0 0 0 0%23:59:46
5okapi 0 0 0 0 0 2523 0%23:57:50
TOTAL: 5 156965 26121 90488 924 25 446342 16%119:57:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.4 GB37.1 MB4.5 GB54.3 KB/s186.9 KB23:59:57
2panorama6.8 MB36.5 MB43.2 MB0.5 KB/s24.0 KB23:59:58
3poznan348.3 KB31.4 KB379.6 KB0.0 KB/s4.8 KB23:59:46
4nask4.3 KB0.0 KB4.3 KB0.0 KB/s2.1 KB23:59:46
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 54.4 GB73.6 MB4.5 GB11.0 KB/s175.2 KB119:57:17
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama15.3 MB
TOTAL: 115.3 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4288.1 KB 15 0 000:00:21
TOTAL: 1 288 4288.1 KB 15 0 000:00:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 672 4288.1 KB 15 0 000:00:27
2unresolved 2 00.0 KB 0 0 000:00:16
TOTAL: 2 674 4288.1 KB 15 0 000:00:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.268 3.076 0.00000:00:21
185.48.194.49 0.000 0.032 0.00000:00:16
mon.man.lodz.pl 1.084 2.852 0.00000:00:05
david.man.lodz.pl 0.312 1.080 0.00000:00:01
TOTAL: 4 2.664 7.040 0.00000:00:44

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
185.48.194.49 2
TOTAL: 3 386

Newsgroup request counts (by category):

CategoryCountPct
1pl 42100.0%
TOTAL: 1 42100.0%

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

NewsgroupCount
1pl.comp.pecet 38
2pl.comp.os.ms-windows.winnt 4
TOTAL: 2 42