Daily Usenet report

Sep 24 04:15:02 -- Sep 25 04:15:02

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Sep 24 07:19:15 newsfeed overchan[23032]: input line too long, skipping
Sep 24 11:30:34 newsfeed overchan[23032]: input line too long, skipping
Sep 24 11:30:54 newsfeed overchan[23032]: input line too long, skipping
Sep 24 19:25:08 newsfeed overchan[23032]: input line too long, skipping
Sep 24 20:08:28 newsfeed overchan[23032]: input line too long, skipping
Sep 24 20:14:11 newsfeed overchan[23032]: input line too long, skipping
Sep 24 20:32:17 newsfeed overchan[23032]: input line too long, skipping
Sep 24 20:56:26 newsfeed overchan[23032]: input line too long, skipping
Sep 24 21:16:19 newsfeed overchan[1052]: input line too long, skipping
Sep 25 02:28:41 newsfeed overchan[1052]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn3170853 96.2%372.6 MB 95.9%
innd 75228 2.3%10.2 MB 2.6%
innfeed 44123 1.3%5.2 MB 1.3%
nnrpd 4762 0.1%494.7 KB 0.1%
overchan 11 0.0%2.1 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 63294979 100.0%388.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3120577 73.7%
Negative hits 1023245 24.2%
Positive hits 92004 2.2%
Cache misses 483 0.0%
TOTAL: 4 4236309 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.117 0.0%192 0.000 16.234 341.000
article cleanup00:00:51.251 0.1%3171319 0.012 0.016 0.020
article logging00:02:28.898 0.2%3171816 0.035 0.047 0.185
article parse01:22:30.888 5.7%173546111 0.019 0.029 0.048
article write00:33:23.481 2.3%3080956 0.427 0.650 1.639
artlog/artcncl00:00:00.003 0.0%191 0.000 0.016 1.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:04:24.919 0.3%192878205 0.001 0.001 0.003
hisgrep/artcncl00:00:00.854 0.0%186 0.000 4.591 69.750
hishave/artcncl00:00:00.033 0.0%192 0.000 0.172 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:34:16.309 2.4%4255735 0.021 0.483 2.900
history sync00:00:00.020 0.0%289 0.000 0.069 1.000
history write01:32:20.059 6.4%3135979 0.269 1.767 10.314
hiswrite/artcncl00:00:00.644 0.0%6 0.000 107.333 644.000
idle10:44:52.404 44.8%100459048 0.286 0.385 0.691
nntp read01:22:52.913 5.8%171221644 0.021 0.029 0.041
overview write00:00:19.905 0.0%3080956 0.005 0.006 0.008
perl filter06:58:04.767 29.0%3135977 6.805 7.999 9.041
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:59.492 0.4%6281447 0.045 0.057 0.086
TOTAL: 24:00:06.93723:22:29.957 97.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.602 0.0%156491 0.000 0.004 0.013
article prepare00:00:00.013 0.0%38354 0.000 0.000 0.025
article read00:00:58.877 0.1%9497 0.197 6.200 534.500
backlog stats00:00:00.417 0.0%504647 0.000 0.001 0.003
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:06.486 0.0%338865 0.010 0.019 0.086
data write00:00:20.833 0.0%231468 0.018 0.090 0.732
idle23:40:54.071 99.8%504647 45.682 168.938 1053.368
status file00:00:16.732 0.0%15780 0.608 1.060 7.967
TOTAL: 23:43:03.54823:42:38.031100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.272 42.5%3034 0.000 6.352 25.444
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.194 0.4%6760 0.000 0.029 1.000
readart00:00:00.004 0.0%58 0.000 0.069 0.500
TOTAL: 00:00:45.38400:00:19.470 42.9%----

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 963 31281013025532 49587 52982 96%482:41:55
2news.nask.pl 2 95270 50980 7057 37233 53%24:03:30
3news.icm.edu.pl 49 257 36 207 14 14%17:08:06
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 1015 32236283076548 56851 90229 95%523:53:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl914.2 GB9.1 GB12.6 GB935.8 GB 97%318.8 KB
2news.nask.pl14.1 GB235.1 MB7.0 GB21.3 GB 66%252.6 KB
3news.icm.edu.pl752.2 KB0.0 KB438.7 KB1.2 MB 63%23.8 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 4928.2 GB9.3 GB19.6 GB957.1 GB 96%316.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 24 04:15:02 - 04:59:59 82541 2.7% 30.5925.5 GB 2.7%9906.69
Sep 24 05:00:00 - 05:59:59 129594 4.2% 36.0039.4 GB 4.2%11481.38
Sep 24 06:00:00 - 06:59:59 134778 4.4% 37.4442.2 GB 4.5%12297.83
Sep 24 07:00:00 - 07:59:59 134255 4.4% 37.2942.8 GB 4.6%12470.40
Sep 24 08:00:00 - 08:59:59 130112 4.2% 36.1440.3 GB 4.3%11751.69
Sep 24 09:00:00 - 09:59:59 126932 4.1% 35.2640.6 GB 4.4%11837.95
Sep 24 10:00:00 - 10:59:59 134296 4.4% 37.3040.9 GB 4.4%11912.02
Sep 24 11:00:00 - 11:59:59 134958 4.4% 37.4940.1 GB 4.3%11693.12
Sep 24 12:00:00 - 12:59:59 140974 4.6% 39.1641.3 GB 4.5%12038.44
Sep 24 13:00:00 - 13:59:59 140408 4.6% 39.0040.0 GB 4.3%11660.33
Sep 24 14:00:00 - 14:59:59 140166 4.6% 38.9440.0 GB 4.3%11652.44
Sep 24 15:00:00 - 15:59:59 116369 3.8% 32.3237.0 GB 4.0%10772.54
Sep 24 16:00:00 - 16:59:59 118189 3.8% 32.8337.2 GB 4.0%10825.75
Sep 24 17:00:00 - 17:59:59 108320 3.5% 30.0935.1 GB 3.8%10222.75
Sep 24 18:00:00 - 18:59:59 118577 3.9% 32.9434.5 GB 3.7%10037.25
Sep 24 19:00:00 - 19:59:59 129793 4.2% 36.0538.9 GB 4.2%11324.95
Sep 24 20:00:00 - 20:59:59 150454 4.9% 41.7938.4 GB 4.1%11197.47
Sep 24 21:00:00 - 21:59:59 152561 5.0% 42.3839.5 GB 4.3%11498.02
Sep 24 22:00:00 - 22:59:59 135102 4.4% 37.5339.0 GB 4.2%11360.56
Sep 24 23:00:00 - 23:59:59 119565 3.9% 33.2137.0 GB 4.0%10769.04
Sep 25 00:00:00 - 00:59:59 105428 3.4% 29.2932.5 GB 3.5%9478.29
Sep 25 01:00:00 - 01:59:59 126020 4.1% 35.0139.3 GB 4.2%11435.38
Sep 25 02:00:00 - 02:59:59 126152 4.1% 35.0440.2 GB 4.3%11701.36
Sep 25 03:00:00 - 03:59:59 115095 3.7% 31.9736.8 GB 4.0%10719.55
Sep 25 04:00:00 - 04:15:02 29193 0.9% 32.369.6 GB 1.0%11148.67
TOTAL: 24:00:00 3079832 100.0% 35.65928.2 GB 100.0%11264.85
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 53346 99 0 34266 0 0 0 018981
2news.nask.pl 37466 10 0 1069 1 0 0 036386
3news.icm.edu.pl 18 0 0 0 0 0 0 0 18
TOTAL: 3 90830 109 0 35335 1 0 0 055385

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 67
it.tlc.cellulari.android 19
comp.mobile.ipad 7
it.comp.os.win.windows10 7
de.rec.sf.startrek 3
comp.mobile.android 2
it.discussioni.energia 2
it.comp.os.win.windows7 1
it.tlc.cellulari.iphone 1
TOTAL: 9 109

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 51999
EMP (md5) 2789
Scoring filter (8) 48
Scoring filter (9) 21
HTML post 10
Scoring filter (10) 7
Poison newsgroup 5
Too many newsgroups 3
EMP (phl) 2
Scoring filter (12) 1
Scoring filter (11) 1
TOTAL: 11 54886

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 319
news.nask.pl 176
news.icm.edu.pl 2
TOTAL: 3 497
TOTAL: 1 497

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 125134 1537 110381 6120 0 0 1%23:50:04
2panorama 49248 563 22118 171 5 137211 1%23:59:01
3nask 56219 480 53514 26 0 0 0%23:50:04
4poznan 13487 177 8929 21 0 0 1%23:50:04
5okapi 0 0 0 0 0 1707 0%23:47:58
TOTAL: 5 244088 2757 194942 6338 5 138918 1%119:17:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm284.6 MB2.3 GB2.6 GB31.8 KB/s356.2 KB23:50:04
2nask163.0 MB8.8 MB171.8 MB2.1 KB/s347.7 KB23:50:04
3panorama2.3 MB754.0 KB3.0 MB0.0 KB/s4.2 KB23:59:01
4poznan602.4 KB172.4 KB774.8 KB0.0 KB/s3.9 KB23:50:04
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:58
TOTAL: 5450.5 MB2.3 GB2.8 GB6.8 KB/s319.6 KB119:17:11
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama4.3 MB
okapi488.4 KB
TOTAL: 24.8 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 5848.7 KB 29 0 000:00:31
TOTAL: 1 288 5848.7 KB 29 0 000:00:44

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 672 5848.7 KB 29 0 000:00:44
TOTAL: 1 672 5848.7 KB 29 0 000:00:44

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.444 4.100 0.00000:00:31
mon.man.lodz.pl 1.208 3.904 0.00000:00:09
david.man.lodz.pl 0.456 1.204 0.00000:00:03
TOTAL: 3 3.108 9.208 0.00000:00:44

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 58100.0%
TOTAL: 1 58100.0%

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

NewsgroupCount
1pl.comp.pecet 54
2pl.comp.os.ms-windows.winnt 4
TOTAL: 2 58